builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0324 starttime: 1468432415.9 results: success (0) buildid: 20160713083327 builduid: c8bc05d5d2874b539709564ee0afa8f3 revision: 9efa66f1c6a15449be7a3c37ade8e104ce2afef8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:35.897961) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:35.898440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:35.898722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:36.076450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 10:53:36.077203) ========= 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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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-07-13 10:53:36-- 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% 178M=0s 2016-07-13 10:53:36 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140822 ========= master_lag: 1.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 10:53:37.408735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:37.409177) ========= 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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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.025512 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:37.735221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-07-13 10:53:37.735661) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9efa66f1c6a15449be7a3c37ade8e104ce2afef8 --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 9efa66f1c6a15449be7a3c37ade8e104ce2afef8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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-07-13 10:53:38,899 truncating revision to first 12 chars 2016-07-13 10:53:38,899 Setting DEBUG logging. 2016-07-13 10:53:38,900 attempt 1/10 2016-07-13 10:53:38,900 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9efa66f1c6a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 10:53:39,856 unpacking tar archive at: fx-team-9efa66f1c6a1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.224827 ========= master_lag: 3.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-07-13 10:53:42.278275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:42.278622) ========= script_repo_revision: 9efa66f1c6a15449be7a3c37ade8e104ce2afef8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 10:53:42.279061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 mins, 33 secs) (at 2016-07-13 10:53:42.279330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 mins, 33 secs) (at 2016-07-13 10:56:15.330272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-07-13 10:56:15.330721) ========= /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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:56:16 INFO - MultiFileLogger online at 20160713 10:56:16 in /builds/slave/test 10:56: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 10:56:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:16 INFO - {'append_to_log': False, 10:56:16 INFO - 'base_work_dir': '/builds/slave/test', 10:56:16 INFO - 'blob_upload_branch': 'Fx-Team', 10:56:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:16 INFO - 'branch': 'Fx-Team', 10:56:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:16 INFO - 'config_files': ('talos/mac_config.py',), 10:56:16 INFO - 'default_actions': ('clobber', 10:56:16 INFO - 'read-buildbot-config', 10:56:16 INFO - 'download-and-extract', 10:56:16 INFO - 'populate-webroot', 10:56:16 INFO - 'create-virtualenv', 10:56:16 INFO - 'install', 10:56:16 INFO - 'run-tests'), 10:56:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:16 INFO - 'download_minidump_stackwalk': True, 10:56:16 INFO - 'download_symbols': 'ondemand', 10:56:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:16 INFO - 'installer_path': 'installer.exe', 10:56:16 INFO - 'log_level': 'info', 10:56:16 INFO - 'log_name': 'talos', 10:56:16 INFO - 'log_to_console': True, 10:56:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:56:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:56:16 INFO - 'opt_config_files': (), 10:56:16 INFO - 'pip_index': False, 10:56:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:56:16 INFO - 'cmd': ('bash', 10:56:16 INFO - '-c', 10:56:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:56:16 INFO - 'enabled': True, 10:56:16 INFO - 'halt_on_failure': False, 10:56:16 INFO - 'name': 'check_screen_resolution'},), 10:56:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:56:16 INFO - 'cmd': ('bash', 10:56:16 INFO - '-c', 10:56:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:56:16 INFO - 'enabled': True, 10:56:16 INFO - 'halt_on_failure': False, 10:56:16 INFO - 'name': 'check_screen_resolution'},), 10:56:16 INFO - 'run_cmd_checks_enabled': True, 10:56:16 INFO - 'sps_profile': False, 10:56:16 INFO - 'sps_profile_interval': 0, 10:56:16 INFO - 'suite': 'dromaeojs-e10s', 10:56:16 INFO - 'system_bits': '32', 10:56:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:16 INFO - 'title': 't-yosemite-r7-0324', 10:56:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:16 INFO - 'use_talos_json': True, 10:56:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:16 INFO - 'work_dir': 'build'} 10:56:16 INFO - ##### 10:56:16 INFO - ##### Running clobber step. 10:56:16 INFO - ##### 10:56:16 INFO - Running pre-action listener: _resource_record_pre_action 10:56:16 INFO - Running main action method: clobber 10:56:16 INFO - rmtree: /builds/slave/test/build 10:56:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:17 INFO - Running post-action listener: _resource_record_post_action 10:56:17 INFO - ##### 10:56:17 INFO - ##### Finished clobber step (success) 10:56:17 INFO - ##### 10:56:17 INFO - ##### 10:56:17 INFO - ##### Running read-buildbot-config step. 10:56:17 INFO - ##### 10:56:17 INFO - Running pre-action listener: _resource_record_pre_action 10:56:17 INFO - Running main action method: read_buildbot_config 10:56:17 INFO - Using buildbot properties: 10:56:17 INFO - { 10:56:17 INFO - "project": "", 10:56:17 INFO - "product": "firefox", 10:56:17 INFO - "script_repo_revision": "production", 10:56:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:56:17 INFO - "repository": "", 10:56:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:56:17 INFO - "buildid": "20160713083327", 10:56:17 INFO - "pgo_build": "False", 10:56:17 INFO - "basedir": "/builds/slave/test", 10:56:17 INFO - "buildnumber": 32, 10:56:17 INFO - "slavename": "t-yosemite-r7-0324", 10:56:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:56:17 INFO - "platform": "yosemite_r7", 10:56:17 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:56:17 INFO - "branch": "fx-team", 10:56:17 INFO - "repo_path": "integration/fx-team", 10:56:17 INFO - "revision": "9efa66f1c6a15449be7a3c37ade8e104ce2afef8", 10:56:17 INFO - "stage_platform": "macosx64", 10:56:17 INFO - "builduid": "c8bc05d5d2874b539709564ee0afa8f3", 10:56:17 INFO - "slavebuilddir": "test" 10:56:17 INFO - } 10:56:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:56:17 INFO - Running post-action listener: _resource_record_post_action 10:56:17 INFO - ##### 10:56:17 INFO - ##### Finished read-buildbot-config step (success) 10:56:17 INFO - ##### 10:56:17 INFO - ##### 10:56:17 INFO - ##### Running download-and-extract step. 10:56:17 INFO - ##### 10:56:17 INFO - Running pre-action listener: _resource_record_pre_action 10:56:17 INFO - Running main action method: download_and_extract 10:56:17 INFO - mkdir: /builds/slave/test/build/tests 10:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:17 INFO - https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:56:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:56:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:56:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:56:19 INFO - Downloaded 1199 bytes. 10:56:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:56:19 INFO - Using the following test package requirements: 10:56:19 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:56:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:56:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:56:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'jsshell-mac.zip'], 10:56:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:56:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:56:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:56:19 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:56:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:56:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:56:19 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:56:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:19 INFO - https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:56:20 INFO - Downloaded 18827281 bytes. 10:56:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:56:23 INFO - Return code: 0 10:56:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:23 INFO - https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:56:24 INFO - Downloaded 18827281 bytes. 10:56:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:56:28 INFO - Return code: 0 10:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:28 INFO - https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:56:29 INFO - Downloaded 14403317 bytes. 10:56:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:56:29 INFO - Return code: 0 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:29 INFO - https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:56:32 INFO - Downloaded 112760320 bytes. 10:56:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:56:32 INFO - mkdir: /builds/slave/test/properties 10:56:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:32 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:32 INFO - Contents: 10:56:32 INFO - build_url:https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:56:33 INFO - Running post-action listener: _resource_record_post_action 10:56:33 INFO - Running post-action listener: set_extra_try_arguments 10:56:33 INFO - ##### 10:56:33 INFO - ##### Finished download-and-extract step (success) 10:56:33 INFO - ##### 10:56:33 INFO - ##### 10:56:33 INFO - ##### Running populate-webroot step. 10:56:33 INFO - ##### 10:56:33 INFO - Running pre-action listener: _resource_record_pre_action 10:56:33 INFO - Running main action method: populate_webroot 10:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:33 INFO - '--tppagecycles', 10:56:33 INFO - '7'], 10:56:33 INFO - 'tests': ['tsvgm']}}, 10:56:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:56:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:56:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:56:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['damp', 'tps']}, 10:56:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'tests': ['damp', 'tps']}, 10:56:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['dromaeo_dom']}, 10:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['basic_compositor_video']}, 10:56:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:56:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['a11yr', 10:56:33 INFO - 'ts_paint', 10:56:33 INFO - 'tpaint', 10:56:33 INFO - 'sessionrestore', 10:56:33 INFO - 'sessionrestore_no_auto_restore', 10:56:33 INFO - 'tabpaint']}, 10:56:33 INFO - 'other-e10s': {'tests': ['a11yr', 10:56:33 INFO - 'ts_paint', 10:56:33 INFO - 'tpaint', 10:56:33 INFO - 'sessionrestore', 10:56:33 INFO - 'sessionrestore_no_auto_restore', 10:56:33 INFO - 'tabpaint']}, 10:56:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:56:33 INFO - 'ts_paint', 10:56:33 INFO - 'tpaint', 10:56:33 INFO - 'sessionrestore', 10:56:33 INFO - 'sessionrestore_no_auto_restore', 10:56:33 INFO - 'tabpaint']}, 10:56:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:56:33 INFO - 'ts_paint', 10:56:33 INFO - 'tpaint', 10:56:33 INFO - 'sessionrestore', 10:56:33 INFO - 'sessionrestore_no_auto_restore', 10:56:33 INFO - 'tabpaint']}, 10:56:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['a11yr', 10:56:33 INFO - 'ts_paint', 10:56:33 INFO - 'tpaint', 10:56:33 INFO - 'sessionrestore', 10:56:33 INFO - 'sessionrestore_no_auto_restore', 10:56:33 INFO - 'tabpaint']}, 10:56:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['a11yr', 10:56:33 INFO - 'ts_paint', 10:56:33 INFO - 'tpaint', 10:56:33 INFO - 'sessionrestore', 10:56:33 INFO - 'sessionrestore_no_auto_restore', 10:56:33 INFO - 'tabpaint']}, 10:56:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['tsvgx', 10:56:33 INFO - 'tsvgr_opacity', 10:56:33 INFO - 'tart', 10:56:33 INFO - 'tscrollx', 10:56:33 INFO - 'cart']}, 10:56:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:56:33 INFO - 'tsvgr_opacity', 10:56:33 INFO - 'tart', 10:56:33 INFO - 'tscrollx', 10:56:33 INFO - 'cart']}, 10:56:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'talos_options': ['--disable-e10s'], 10:56:33 INFO - 'tests': ['tp5o']}, 10:56:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'tests': ['tp5o']}, 10:56:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'talos_options': ['--disable-e10s', 10:56:33 INFO - '--xperf_path', 10:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:33 INFO - 'tests': ['tp5n']}, 10:56:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:33 INFO - 'talos_options': ['--xperf_path', 10:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:33 INFO - 'tests': ['tp5n']}}, 10:56:33 INFO - 'talos.zip': {'path': '', 10:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:33 INFO - Running post-action listener: _resource_record_post_action 10:56:33 INFO - ##### 10:56:33 INFO - ##### Finished populate-webroot step (success) 10:56:33 INFO - ##### 10:56:33 INFO - ##### 10:56:33 INFO - ##### Running create-virtualenv step. 10:56:33 INFO - ##### 10:56:33 INFO - Running pre-action listener: _resource_record_pre_action 10:56:33 INFO - Running main action method: create_virtualenv 10:56:33 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:33 INFO - Using real prefix '/tools/python27' 10:56:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:37 INFO - Installing pip.................done. 10:56:37 INFO - Return code: 0 10:56:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:37 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:37 INFO - 'HOME': '/Users/cltbld', 10:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:37 INFO - 'LOGNAME': 'cltbld', 10:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:37 INFO - 'MOZ_NO_REMOTE': '1', 10:56:37 INFO - 'NO_EM_RESTART': '1', 10:56:37 INFO - 'PAGER': '/bin/cat', 10:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:37 INFO - 'PWD': '/builds/slave/test', 10:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:37 INFO - 'SHELL': '/bin/bash', 10:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:37 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:37 INFO - 'USER': 'cltbld', 10:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:37 INFO - 'XPC_FLAGS': '0x0', 10:56:37 INFO - 'XPC_SERVICE_NAME': '0', 10:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:56:37 INFO - Cleaning up... 10:56:37 INFO - Return code: 0 10:56:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:37 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:56:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:37 INFO - 'HOME': '/Users/cltbld', 10:56:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:37 INFO - 'LOGNAME': 'cltbld', 10:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:37 INFO - 'MOZ_NO_REMOTE': '1', 10:56:37 INFO - 'NO_EM_RESTART': '1', 10:56:37 INFO - 'PAGER': '/bin/cat', 10:56:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:37 INFO - 'PWD': '/builds/slave/test', 10:56:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:37 INFO - 'SHELL': '/bin/bash', 10:56:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:37 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:37 INFO - 'USER': 'cltbld', 10:56:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:37 INFO - 'XPC_FLAGS': '0x0', 10:56:37 INFO - 'XPC_SERVICE_NAME': '0', 10:56:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:37 INFO - Downloading/unpacking psutil>=3.1.1 10:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:41 INFO - Installing collected packages: psutil 10:56:41 INFO - Running setup.py install for psutil 10:56:41 INFO - building 'psutil._psutil_osx' extension 10:56:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:56:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:56:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:56:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:56:42 INFO - building 'psutil._psutil_posix' extension 10:56:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:56:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:56:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:56:42 INFO - ^ 10:56:42 INFO - 1 warning generated. 10:56:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:42 INFO - Successfully installed psutil 10:56:42 INFO - Cleaning up... 10:56:42 INFO - Return code: 0 10:56:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:42 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:42 INFO - 'HOME': '/Users/cltbld', 10:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:42 INFO - 'LOGNAME': 'cltbld', 10:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:42 INFO - 'MOZ_NO_REMOTE': '1', 10:56:42 INFO - 'NO_EM_RESTART': '1', 10:56:42 INFO - 'PAGER': '/bin/cat', 10:56:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:42 INFO - 'PWD': '/builds/slave/test', 10:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:42 INFO - 'SHELL': '/bin/bash', 10:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:42 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:42 INFO - 'USER': 'cltbld', 10:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:42 INFO - 'XPC_FLAGS': '0x0', 10:56:42 INFO - 'XPC_SERVICE_NAME': '0', 10:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:56:45 INFO - Installing collected packages: mozsystemmonitor 10:56:45 INFO - Running setup.py install for mozsystemmonitor 10:56:45 INFO - Successfully installed mozsystemmonitor 10:56:45 INFO - Cleaning up... 10:56:45 INFO - Return code: 0 10:56:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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', '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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:56: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 jsonschema==2.5.1 10:56:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:45 INFO - 'HOME': '/Users/cltbld', 10:56:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:45 INFO - 'LOGNAME': 'cltbld', 10:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:45 INFO - 'MOZ_NO_REMOTE': '1', 10:56:45 INFO - 'NO_EM_RESTART': '1', 10:56:45 INFO - 'PAGER': '/bin/cat', 10:56:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:45 INFO - 'PWD': '/builds/slave/test', 10:56:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:45 INFO - 'SHELL': '/bin/bash', 10:56:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:45 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:45 INFO - 'USER': 'cltbld', 10:56:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:45 INFO - 'XPC_FLAGS': '0x0', 10:56:45 INFO - 'XPC_SERVICE_NAME': '0', 10:56:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:45 INFO - Downloading/unpacking jsonschema==2.5.1 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:48 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:48 INFO - warning: no files found matching '*.txt' 10:56:48 INFO - no previously-included directories found matching 'build' 10:56:48 INFO - no previously-included directories found matching 'dist' 10:56:48 INFO - no previously-included directories found matching '.git*' 10:56:48 INFO - Installing collected packages: jsonschema, functools32 10:56:48 INFO - Running setup.py install for functools32 10:56:48 INFO - warning: no files found matching '*.txt' 10:56:48 INFO - no previously-included directories found matching 'build' 10:56:48 INFO - no previously-included directories found matching 'dist' 10:56:48 INFO - no previously-included directories found matching '.git*' 10:56:48 INFO - Successfully installed jsonschema functools32 10:56:48 INFO - Cleaning up... 10:56:48 INFO - Return code: 0 10:56:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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', '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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:56: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 blobuploader==1.2.4 10:56:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:48 INFO - 'HOME': '/Users/cltbld', 10:56:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:48 INFO - 'LOGNAME': 'cltbld', 10:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:48 INFO - 'MOZ_NO_REMOTE': '1', 10:56:48 INFO - 'NO_EM_RESTART': '1', 10:56:48 INFO - 'PAGER': '/bin/cat', 10:56:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:48 INFO - 'PWD': '/builds/slave/test', 10:56:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:48 INFO - 'SHELL': '/bin/bash', 10:56:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:48 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:48 INFO - 'USER': 'cltbld', 10:56:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:48 INFO - 'XPC_FLAGS': '0x0', 10:56:48 INFO - 'XPC_SERVICE_NAME': '0', 10:56:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:56:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:52 INFO - Downloading docopt-0.6.1.tar.gz 10:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:52 INFO - Running setup.py install for blobuploader 10:56:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:56:52 INFO - Running setup.py install for requests 10:56:53 INFO - Running setup.py install for docopt 10:56:53 INFO - Successfully installed blobuploader requests docopt 10:56:53 INFO - Cleaning up... 10:56:53 INFO - Return code: 0 10:56:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:53 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:53 INFO - 'HOME': '/Users/cltbld', 10:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:53 INFO - 'LOGNAME': 'cltbld', 10:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:53 INFO - 'MOZ_NO_REMOTE': '1', 10:56:53 INFO - 'NO_EM_RESTART': '1', 10:56:53 INFO - 'PAGER': '/bin/cat', 10:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:53 INFO - 'PWD': '/builds/slave/test', 10:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:53 INFO - 'SHELL': '/bin/bash', 10:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:53 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:53 INFO - 'USER': 'cltbld', 10:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:53 INFO - 'XPC_FLAGS': '0x0', 10:56:53 INFO - 'XPC_SERVICE_NAME': '0', 10:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-ETM2Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-aJYi_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-hOxoED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-9CfzAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-1YRpux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-ravBby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-bGPRj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-Pn2ltE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-M6VFM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:54 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-3lbI6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-fkAPTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-M5dKL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-eHDK4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-Rsrqte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-Dy4hIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-5IFru6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:55 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-JnKQdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:55 INFO - Running setup.py install for manifestparser 10:56:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:56:55 INFO - Running setup.py install for mozcrash 10:56:56 INFO - Running setup.py install for mozdebug 10:56:56 INFO - Running setup.py install for mozdevice 10:56:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Running setup.py install for mozfile 10:56:56 INFO - Running setup.py install for mozhttpd 10:56:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Running setup.py install for mozinfo 10:56:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Running setup.py install for mozInstall 10:56:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:56:56 INFO - Running setup.py install for mozleak 10:56:57 INFO - Running setup.py install for mozlog 10:56:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:56:57 INFO - Running setup.py install for moznetwork 10:56:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:56:57 INFO - Running setup.py install for mozprocess 10:56:57 INFO - Running setup.py install for mozprofile 10:56:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:56:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:56:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:56:57 INFO - Running setup.py install for mozrunner 10:56:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:56:57 INFO - Running setup.py install for mozscreenshot 10:56:58 INFO - Running setup.py install for moztest 10:56:58 INFO - Running setup.py install for mozversion 10:56:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:56:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:58 INFO - Cleaning up... 10:56:58 INFO - Return code: 0 10:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:58 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:58 INFO - 'HOME': '/Users/cltbld', 10:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:58 INFO - 'LOGNAME': 'cltbld', 10:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:58 INFO - 'MOZ_NO_REMOTE': '1', 10:56:58 INFO - 'NO_EM_RESTART': '1', 10:56:58 INFO - 'PAGER': '/bin/cat', 10:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:58 INFO - 'PWD': '/builds/slave/test', 10:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:58 INFO - 'SHELL': '/bin/bash', 10:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:56:58 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:58 INFO - 'USER': 'cltbld', 10:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:58 INFO - 'XPC_FLAGS': '0x0', 10:56:58 INFO - 'XPC_SERVICE_NAME': '0', 10:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:58 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-hgrxt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:58 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-QH2udu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:58 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-GnFUvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:58 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-KEedfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-HRc0dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-P3GQXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-kbTzfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-VQcVkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-LKaoAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-x5s5_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-YE_2ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-ZvKeM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:59 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-zHRqVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:00 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-7WwoLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:00 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-LEfLIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:00 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-kLPX32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:00 INFO - Running setup.py (path:/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/pip-8jIFiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:02 INFO - Downloading blessings-1.6.tar.gz 10:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:03 INFO - Installing collected packages: blessings 10:57:03 INFO - Running setup.py install for blessings 10:57:03 INFO - Successfully installed blessings 10:57:03 INFO - Cleaning up... 10:57:03 INFO - Return code: 0 10:57:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:03 INFO - Reading from file tmpfile_stdout 10:57:03 INFO - Current package versions: 10:57:03 INFO - blessings == 1.6 10:57:03 INFO - blobuploader == 1.2.4 10:57:03 INFO - docopt == 0.6.1 10:57:03 INFO - functools32 == 3.2.3-2 10:57:03 INFO - jsonschema == 2.5.1 10:57:03 INFO - manifestparser == 1.1 10:57:03 INFO - mozInstall == 1.12 10:57:03 INFO - mozcrash == 0.17 10:57:03 INFO - mozdebug == 0.1 10:57:03 INFO - mozdevice == 0.48 10:57:03 INFO - mozfile == 1.2 10:57:03 INFO - mozhttpd == 0.7 10:57:03 INFO - mozinfo == 0.9 10:57:03 INFO - mozleak == 0.1 10:57:03 INFO - mozlog == 3.2 10:57:03 INFO - moznetwork == 0.27 10:57:03 INFO - mozprocess == 0.23 10:57:03 INFO - mozprofile == 0.28 10:57:03 INFO - mozrunner == 6.12 10:57:03 INFO - mozscreenshot == 0.1 10:57:03 INFO - mozsystemmonitor == 0.3 10:57:03 INFO - moztest == 0.7 10:57:03 INFO - mozversion == 1.4 10:57:03 INFO - psutil == 3.1.1 10:57:03 INFO - requests == 1.2.3 10:57:03 INFO - wsgiref == 0.1.2 10:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:03 INFO - 'HOME': '/Users/cltbld', 10:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:03 INFO - 'LOGNAME': 'cltbld', 10:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:03 INFO - 'MOZ_NO_REMOTE': '1', 10:57:03 INFO - 'NO_EM_RESTART': '1', 10:57:03 INFO - 'PAGER': '/bin/cat', 10:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:03 INFO - 'PWD': '/builds/slave/test', 10:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:03 INFO - 'SHELL': '/bin/bash', 10:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:57:03 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:03 INFO - 'USER': 'cltbld', 10:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:03 INFO - 'XPC_FLAGS': '0x0', 10:57:03 INFO - 'XPC_SERVICE_NAME': '0', 10:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:57:03 INFO - Cleaning up... 10:57:03 INFO - Return code: 0 10:57:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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 0x10fafea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb93618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef78d666e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, '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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:03 INFO - 'HOME': '/Users/cltbld', 10:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:03 INFO - 'LOGNAME': 'cltbld', 10:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:03 INFO - 'MOZ_NO_REMOTE': '1', 10:57:03 INFO - 'NO_EM_RESTART': '1', 10:57:03 INFO - 'PAGER': '/bin/cat', 10:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:03 INFO - 'PWD': '/builds/slave/test', 10:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:03 INFO - 'SHELL': '/bin/bash', 10:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:57:03 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:03 INFO - 'USER': 'cltbld', 10:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:03 INFO - 'XPC_FLAGS': '0x0', 10:57:03 INFO - 'XPC_SERVICE_NAME': '0', 10:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:57:04 INFO - Cleaning up... 10:57:04 INFO - Return code: 0 10:57:04 INFO - Running post-action listener: _resource_record_post_action 10:57:04 INFO - Running post-action listener: _start_resource_monitoring 10:57:04 INFO - Starting resource monitoring. 10:57:04 INFO - ##### 10:57:04 INFO - ##### Finished create-virtualenv step (success) 10:57:04 INFO - ##### 10:57:04 INFO - ##### 10:57:04 INFO - ##### Running install step. 10:57:04 INFO - ##### 10:57:04 INFO - Running pre-action listener: _resource_record_pre_action 10:57:04 INFO - Running main action method: install 10:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:04 INFO - Reading from file tmpfile_stdout 10:57:04 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:04 INFO - Reading from file tmpfile_stdout 10:57:04 INFO - Output received: 10:57:04 INFO - Usage: mozinstall [options] installer 10:57:04 INFO - Options: 10:57:04 INFO - -h, --help show this help message and exit 10:57:04 INFO - -d DEST, --destination=DEST 10:57:04 INFO - Directory to install application into. [default: 10:57:04 INFO - "/builds/slave/test"] 10:57:04 INFO - --app=APP Application being installed. [default: firefox] 10:57:04 INFO - mkdir: /builds/slave/test/build/application 10:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:57:38 INFO - Reading from file tmpfile_stdout 10:57:38 INFO - Output received: 10:57:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:57:38 INFO - Running post-action listener: _resource_record_post_action 10:57:38 INFO - ##### 10:57:38 INFO - ##### Finished install step (success) 10:57:38 INFO - ##### 10:57:38 INFO - ##### 10:57:38 INFO - ##### Running run-tests step. 10:57:38 INFO - ##### 10:57:38 INFO - Running pre-action listener: _resource_record_pre_action 10:57:38 INFO - Running main action method: run_tests 10:57:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:38 INFO - 2016-07-13 10:57:38.613 screenresolution[1648:8098] starting screenresolution argv=screenresolution get 10:57:38 INFO - 2016-07-13 10:57:38.616 screenresolution[1648:8098] Display 0: 1600x1200x32@60 10:57:38 INFO - 2016-07-13 10:57:38.622 screenresolution[1649:8100] starting screenresolution argv=screenresolution list 10:57:38 INFO - Available Modes on Display 0 10:57:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:38 INFO - Intel Iris: 10:57:38 INFO - Chipset Model: Intel Iris 10:57:38 INFO - Type: GPU 10:57:38 INFO - Bus: Built-In 10:57:38 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:38 INFO - Vendor: Intel (0x8086) 10:57:38 INFO - Device ID: 0x0a2e 10:57:38 INFO - Revision ID: 0x0009 10:57:38 INFO - Displays: 10:57:38 INFO - Display: 10:57:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:38 INFO - Display Serial Number: 1600x1200 60 10:57:38 INFO - Main Display: Yes 10:57:38 INFO - Mirror: Off 10:57:38 INFO - Online: Yes 10:57:38 INFO - Rotation: Supported 10:57:38 INFO - Return code: 0 10:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:38 INFO - Python 2.7.3 10:57:38 INFO - Return code: 0 10:57:38 INFO - grabbing minidump binary from tooltool 10:57:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:38 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 0x10fa62d30>, '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 0x10f7c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa5ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:57:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:57:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:57:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:38 INFO - Return code: 0 10:57:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:57:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:57:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:38 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/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:57:38 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/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0324 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8LLfqtQ8cl/Render', 10:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:38 INFO - 'HOME': '/Users/cltbld', 10:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:38 INFO - 'LOGNAME': 'cltbld', 10:57:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:38 INFO - 'MOZ_NO_REMOTE': '1', 10:57:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:38 INFO - 'NO_EM_RESTART': '1', 10:57:38 INFO - 'PAGER': '/bin/cat', 10:57:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:38 INFO - 'PWD': '/builds/slave/test', 10:57:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:38 INFO - 'SHELL': '/bin/bash', 10:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5c1Q7gXYo3/Listeners', 10:57:38 INFO - 'TMPDIR': '/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/', 10:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:38 INFO - 'USER': 'cltbld', 10:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:38 INFO - 'XPC_FLAGS': '0x0', 10:57:38 INFO - 'XPC_SERVICE_NAME': '0', 10:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:38 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/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:57:39 INFO - mozversion application_buildid: 20160713083327 10:57:39 INFO - mozversion application_changeset: 9efa66f1c6a15449be7a3c37ade8e104ce2afef8 10:57:39 INFO - mozversion application_display_name: Nightly 10:57:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:39 INFO - mozversion application_name: Firefox 10:57:39 INFO - mozversion application_remotingname: firefox 10:57:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:57:39 INFO - mozversion application_vendor: Mozilla 10:57:39 INFO - mozversion application_version: 50.0a1 10:57:39 INFO - mozversion platform_buildid: 20160713083327 10:57:39 INFO - mozversion platform_changeset: 9efa66f1c6a15449be7a3c37ade8e104ce2afef8 10:57:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:39 INFO - mozversion platform_version: 50.0a1 10:57:39 INFO - using testdate: 1468432659 10:57:39 INFO - actual date: 1468432659 10:57:39 INFO - starting webserver on 'localhost:49280' 10:57:39 INFO - SUITE-START | Running 2 tests 10:57:39 INFO - TEST-START | dromaeo_css 10:57:39 INFO - operating with platform_type : mac_ 10:57:39 INFO - Initialising browser for dromaeo_css test... 10:57:39 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmpkooqhq/profile http://localhost:49280/getInfo.html) 10:57:42 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 10:57:42 INFO - PROCESS | 1659 | colorDepth:24 10:57:42 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 10:57:42 INFO - PROCESS | 1659 | __metrics 10:57:42 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 10:57:43 INFO - TEST-INFO | 1659: exit 0 10:57:43 INFO - Browser initialized. 10:57:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:43 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmpkooqhq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:55 INFO - PROCESS | 1663 | RSS: Main: 254603264 10:57:55 INFO - PROCESS | 1663 | 10:58:44 INFO - PROCESS | 1663 | 1468432724864 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] 11:00:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 11:00:57 INFO - PROCESS | 1663 | RSS: Main: 267173888 11:00:57 INFO - PROCESS | 1663 | 11:03:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 11:04:00 INFO - PROCESS | 1663 | RSS: Main: 275771392 11:04:00 INFO - PROCESS | 1663 | 11:07:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 11:07:02 INFO - PROCESS | 1663 | RSS: Main: 280113152 11:07:02 INFO - PROCESS | 1663 | 11:10:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 11:10:05 INFO - PROCESS | 1663 | RSS: Main: 279535616 11:10:05 INFO - PROCESS | 1663 | 11:13:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 11:13:08 INFO - PROCESS | 1663 | RSS: Main: 282939392 11:13:08 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 11:16:11 INFO - PROCESS | 1663 | RSS: Main: 283049984 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | __start_tp_report 11:16:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 11:16:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 11:16:11 INFO - PROCESS | 1663 | |i|pagename|runs| 11:16:11 INFO - PROCESS | 1663 | |0;dojo.html;3416.2996585699934;3431.3137372525503;3456.879009234677;3474.6177920428754;3475.766103033423;5838.065909454488;5904.232449781533;5905.173275741399;5917.260342457193;5937.524998000161;5699.401562835895;5808.56435767317;5853.76584936602;5869.8826023479505;5937.940620593793;5309.548688361494;5342.839714808542;5380.7309634518315;5417.674939503623;5444.183372494138;227.67778193127947;5385.542228910547;5396.973015134919;5413.242146099549;5434.945650543484;4307.806148723315;4404.823807047715;5276.12943864262;5329.467053294678;5333.786648534054;4590.380298659705;5130.025295193901;5283.524482796528;5328.786848526093;5339;4610;5265.842024739264;5291.497307755757;5296.523312901819;5336.066188417011;4230.49234091911;5745.626534275259;5893.616914900518;5916.378780228057;6010.78962236324;6121.479674227696;6240.375962403768;6249.781257656005;6301.68491575424;6308.148399965991;5291.656042357235;6237.844053898689;6321;6332.810015699536;6337.112804207414;5994.520438364921;6008.75964961401;6009.218801555813;6032.728527216286;6035.758569657252;6301.464375528131;6385.297617262097;6411.903821442682;6452.645104519296;6487.18910136233;6263.530235232376;6278.937210627927;6280.340564240781;6297.433231009231;6305.243370795442;6318.557700960889;6321.083442900754;6359.17330747;6362.045693145972;6378.968105159537;6174.8147555573405;6207.81376558704;6248.343923887926;6267.9373206267355;6302.873942521124;6151.7539298428455;6190.288116866618;6257.812265632038;6267.9373206267355;6296.496280297565;4958.107540642647;5008.098542262428;5011.699298042129;5016.824411145592;5022.84931452057;4444.955550444519;4492.124035813051;4529.954700452953;4543.636509079266;4622.445306563234;4560.498345182027;5948.988671925783;6018.247719035121;6051.546134039964;6115.449609535074;6275.466585340298;6354.682265886687;6356.364363563699;6359.046143078575;6374.043893416025;5890.970545147246;6090.725917333731;6106.816795496054;6132.8773424532155;6133.539984501181;5114.207297868762;5188.455212202664;5577.832665020056;5590.217369568264;5613.158026296007;6533.052707357407;6572.244191917895;6573.506986975996;6581.6709164542535;6597.472202223715;6238.407351301619;6253.218347706536;6303.338149494421;6336.651484168415;6346.873062538631;5546.668799488174;6411.679416029273;6553.901691474727;6557;6626.768063117768;6274.215723034621;6290.591111577733;6316.178896743394;6334.303226645157;6337.7781777637565;6223.906641400473;6231.40801623845;6237.220347456568;6331.303556608861;6333.58831675958;6230.937690623217;6235.501159907106;6247.312795592572;6249.531285153541;6305.747770089145;5301.602379821606;6215.316315205233;6236.75052997875;6255.749770009149;6290.685465726787;4952.925706114484;5561.388247292875;5873.9412605873395;5880.470757631833;6079.483243924139;5310.362756469249;6065.999110146777;6114.814446323713;6148.415900489446;6182.845428864314;6022.789202377896;6128.1726966858905;6128.754849805958;6139.8465038372615;6152.753889844356 11:16:11 INFO - PROCESS | 1663 | |1;ext.html;482.2838085443114;509.9056674515215;524.5436470270865;562.5527705474148;582.1936617784368;29078.709212907863;37932.051698707546;39735.80132099343;39820;39833.60166398343;41131.58868411322;41759.79120104403;41786.7910660447;41833.7908310458;41936.370954435704;9390.765230869249;9633.855492167588;9666.951665241664;9670.081342272473;9692.321537492378;9413.435193888388;9437.056294370577;9479.289053320994;9506.904930950706;9595;9456.952715236413;9564.330496865223;9622.80754384912;9633.61465541381;9665.661701840438;9539.952300238489;9563.856542151872;9611.903880961207;9615.471149086798;9628.518574071268;9508.524573771352;9527.52362381878;9540.045995400475;9542.284328675378;9638.807223855554;39555.80222098871;39647.60352396468;39857.40213896794;39952.80141595757;40029.59970400288;2775.278427608816;3088.521279201705;3315.8176300303476;3351.798892066484;3558.679718825292;31537.526937095732;31805;32046.839765801255;32812;32972.83513582441;3135.0751528299206;3156.71589556941;3170.381775553768;3177.269228077555;3278.2623909620384;478885;486568;488961;489617;492077.53961230326;33361;33946.32107357839;34052.65947340495;34230;34257.48613770796;34819.30361392758;35461.290774184374;35766.64233357633;35842.82078589642;35857.82071089628;14482.565523034325;14483.275836208148;14499.202543859978;14668.486602968846;14674.192919389323;12256.448459819152;12404.875951240552;12442.626721198378;12495.562655307021;12501;7700.614969251515;7718.343940764986;7745.496542724705;7778.727744528915;7779.560781255486;2796.566532187514;3203.8878639247514;3230.208598893239;3243.31890303039;3273.607167139911;988.1650005745134;989.292655751127;1003.4029752297372;1046.3094357723867;1112.7273817914663;31135.377292454024;31144.688553114633;31168;31184;31792.68207317897;998.6604554451521;1054.082947835388;1067.2262609607972;1084.2464487181492;1100.9889901101046;12504.687382815502;16509.422170223985;16555;16558;16877.40929067477;654647;656939;666632;667522.6623866947;668037;60544.69727651333;62343;62561;62578;62750.0587491188;1361.8025386318927;1363.0050063453734;1382.322661895664;1388.1185447241076;1391.4016972701836;30127.698723013367;30968.845155774077;31375.529367059054;31391;31855.681443185273;52972.735136324074;53533.46466535285;53923;54042.459575403744;54085.72957135189;562278;572000;573953;577418.1129094327;581500;27618.5857212146;27673.723262767115;28028.719712803428;28119.156425307272;28253.728582214262;50312.74843625905;50739.98520029505;50907.981840363725;51364.74317628388;51789.74105129601;34674.306513870084;36990.815045924595;39867.20597573058;41530;41900.790496047324;41224.587754122076;41508.377374340016;41638.791806040776;41959.370609441496;42307;32781.83609081939;39020.2195956085;39191.824245272684;39922.40116398198;40218;33654.49518257277;33957;35843.46234806428;36323.72866949644;36610.8169459151;25034.24897253085;26468.470630586897;26493.33766655849;26739;26894.462110758068 11:16:11 INFO - PROCESS | 1663 | |2;jquery.html;358.6592736899945;386.9438931354954;397.26704230694367;405.266467693475;417.48857649379516;20801;22007.889960550216;23408.180713675025;23434.296971090873;23495.177668781576;22158.778412215914;22455.775442245573;22657;22805.4298642534;22875.313740587768;5951.970240148804;6169.290531588857;6215.56491045627;6227.968860155693;6248.562600617958;4283.336082907154;6077.361877002917;6603.240627327847;6743.651269746046;6957.373836354727;5807.854803629901;6178.413050760193;6979.371856532911;6982.720691172372;6985.161780586312;6112.816615501542;6160.6611636359985;6170.228721409824;6228.501719862423;6245.344238854923;5921.111833225008;5960.821175364746;6021.277446706379;6026.9095963560585;6097.664628445434;14059.015868889182;14158.787618185735;14196.645083872883;22653.77346226533;28076.29809254785;2097.6014557234075;2194.594000109985;2387.77316154965;2445.3886528367907;2505.5615267328326;10856.728581785439;11691.7077073073;12695.428705708266;15628.843711562853;17105.973641581546;1903.6383087213524;1938.709193620954;1982.2269314967175;2010.3767831971988;2016.3749237736201;123660.38169809093;123762;126502;127946.36026819807;129756;11566.65300041;11865.762684746256;11895.583654572049;11940;12031.578894738817;15099.849001509845;15111;15122.39510419593;15168.696626067416;15170.24148792556;8673.6530538779;8743.737687869374;8753.693620723372;8767.561621918878;8869;8672.436291641023;8716.171963663443;8743.519106449206;8793.91206087931;8803.383763136648;4266.402703621496;4645.814167433333;4664;4688;4701.506341834127;1808.367071524982;1824.6511259118447;1870.326682394337;1970.9455441338814;2052.8563000589816;786.622421237809;870.8388948044632;918.8897332320031;945.7115579748105;986.8059647826067;18960.051997400074;19778.30775922836;22212.555748884934;22739.317820465414;22785.316440506813;756.9243075692386;962.41292811385;963.7377477239455;974.3277138774223;1029.9957541397227;9442.678025076495;11003.724906877393;11076.003159715665;11778.116641251769;12069;561415;581877;582070;585601;591285;95926;98129;99005.00994989958;133373;141102;864.7103220421229;1019.9439030853226;1067.412922892406;1081.4808891732014;1090.7600327927844;19989.200431982557;20106.195752169748;20253.898730506255;20313.593728125652;20318.288859890425;53619.731901340245;57154.57113572194;57309.42690573041;57446;57892.710536448736;85949;86361.56819215864;86622.56688716516;87633.56183219043;88363.55818221124;5612.803551875665;6393.87212255743;8150.959245203736;8371.95814020926;8773.956130219309;9734.951325243328;11883.940580297043;13642.727145457235;13899.513517026855;13972.510962116683;11466.484008219484;11467.4266286687;11497.252678575866;11854.822177667169;11986.340751258416;11171.329720216812;11536.711582210512;11631.709207269885;11951;11990.340531270864;11427.542898283975;11855.525778968744;12010.099242557018;12050.397480126134;12081.456334465145;7293.890591641236;7855.096663883498;8475.067742548192;8572.571371431528;8709.911261092364;11242.494087765906;11889.762204756029;12006.459709313276;12048.75902481928;12069.27584344942 11:16:11 INFO - PROCESS | 1663 | |3;mootools.html;1573.7482002879542;1605.2134454117481;1865.6641804475198;1936.5061909213148;1939.883606983581;8330.66709326508;8937.821243575125;9009.414388064779;9468.99999999999;9519.190868776153;8921.95539022304;8989.460632362046;9052.958909725383;9207.07929207079;9232.122948319915;2409.4578719788037;2440.5973014452684;2443.535728211643;2448.2288079254977;2450.3506570758764;2421.69728783902;2426.0902161689364;2452.472718365551;2465.5192237513693;2471.7404672509397;2437.609982402816;2438.085717855804;2439.6462512935705;2447.36368544178;2474.2824580871616;2002.2491565662876;2411.05968672218;2420.116657420038;2424.612062070069;2426.3206302235403;2163.7511686156136;2253.166328458481;2397.700287464067;2410.9397265068337;2418.201993342193;7653.655585498666;9263.536823158882;9317.953410232973;9324.90675093254;9343.486108264044;5471.206675032098;5488.231647569343;5539.224508568804;5560.304961879765;5650.434956504317;3645.453182022718;3716.684081853046;3762.6613604775703;3798.715096367756;3805.1818858945458;1083.101026148303;1115.275071203716;1129.2659771148737;1141.4121727310442;1493.8132733408324;10037.29738918276;12051.819222711667;12215.633530994084;12527.43626536799;12571.497140114385;3986.7807270599815;4563.338315944169;4706.529347065266;4795.568398844121;4802.7838747255755;9433.292503062297;9522.761930951643;9607.039296070338;9629.181519570915;9629.518524073768;5340.75966581497;5378.811741589026;5421;5436.537894278951;5449.891002179934;4537.4328208973875;4850.6362022848425;4854.126257273725;5004.774785134678;5044.470330615306;3901.96098039016;3925.5878132796215;4001.6198461146146;4008.9799551002056;4030.2141082488633;1203.554684766642;1205.9638210853689;1208.4018410886492;1213.6541085790507;1215.8601760797444;927.1192367251003;930.1628534319032;936.3773090894479;947.4126041853957;985.2708995343537;5990.580659353804;6058.636481811017;6151.569390142647;6194.318624951252;6231.9094158522075;369.83357489129463;448.3812338972198;458.52542618389805;458.53687775346475;466.1097304149059;3987.5813039631003;4085.101277718897;4152.231837110145;4153.190127925086;4190.497140343178;11059.22585419013;11074.280171788809;11358.886411135949;11512.19414640967;11518;11195;11373;11412.087033037336;11412.657620271239;11425.028872545927;8453.873191902127;8542.701005464778;8649.56752162402;8665.653373864974;8672.913270867337;6044.0933859919605;6115.84710382244;6119.4798442132915;6178.227721534809;6195.566310358232;10026.849597256192;10083.14293285079;10168.186545076229;10194.133498652402;10461.320014199053;10419.479026048819;10594.046535811814;10719.088877445505;10721.249512534048;10758.784824303313;6606.207255129415;7234.16807067194;7313.67088481009;7315.597642129521;7396.186419493959;8654.870176947477;8783.912160878564;8826.91173088261;8886.422382545372;8891.599878005634;7667.194944530744;7740.225977402215;7868.25251601097;7903.170167132598;7922.4850384724805;7644.12092609357;7720.112187098331;7749.263819937097;7854.450188486751;7859.331956783737;7141.464390170654;7223;7259.491835571459;7319.926800731924;7396.519226250277;5164.1995490699;5190;5219.947800521946;5292.788288468572;5356.678599284055;4271.252530807034;5120.694222973118;5199.116150254541;5270.947290527046;5362.597805164706 11:16:11 INFO - PROCESS | 1663 | |4;prototype.html;316.08966177409064;323.2677984365413;323.5841943103113;328.71073455359283;332.31045580420636;4949.8367883547335;5602.2436971009;5724.771009159639;5756.625819321746;5766.711664416778;4270.444842170521;4603.8720513474245;5635.63368381056;5649.971750141243;5694.747155625766;4086.856960006408;4167.416561681367;4292.377605247238;4326.372675961984;4328.415663885383;4248.022954720416;4312.547182545834;4334.631556317717;4334.956650433503;4356.607905288523;3678.742488025839;4287.6569874410125;4298.1517947282655;4311.590398912098;4317.783251477638;3234.9648112603977;3995.580464051262;4235.475228917588;4252.617264446184;4252.766097864616;3640.2173532690335;3648.7810731356203;3663.358912190356;3665.9450108248398;3668.5414323209598;5231.189165679326;5369.71126929538;5535.6955367454775;5561.580712390123;5617.719114044281;4070.75575465473;4353.020570371641;4626.58360747531;4892.9755351223375;4898.804047838083;5148.871278218037;5961.91057134139;5969.462748352669;5981.491573216282;6032.306284777219;4014.959850401488;4029.1191797864667;4034.245103380039;4041.4948131483566;4042.4744783178294;5164.793408263665;5364.383095943977;5441.619086663935;5467.972660136674;6417.647029413381;3391.6947474727394;4016.8192431340076;4080.326746086922;4101.835926562963;4104.56902025283;3650.3064417760543;4172.728772629769;4173.770442625685;4176.394422808737;4183.163367326547;4675.574888150686;4857.271409288635;4882.7558622068755;4909.459959404463;4927.482614325516;4946.802127914915;5504.862378440571;5978.342382337939;6036.649659439054;6047.7278522466595;1188.7028242939266;1391.4503771010598;1410.104583589428;1420.5596265157835;1422.8972546276718;751.7331347371713;762.4891322813728;824.2128767027594;852.0074113657644;903.6972614174325;5091.389033316026;5519.530839878656;5528.834134975958;5563.91353242534;5600.775968961196;5811.738471768781;6078.361772013964;6127.417895300028;6140.990914451886;6147.66187859672;5280.498352656491;5499.230107784913;5551.7799676187715;5570.546261317928;5617.550595952314;3218.7585931054796;3231.321422501301;3231.531427942935;3231.8060916345094;3235.1074621346306;5967.433093856077;6356.4574170332235;6360.491160707133;6378.362163783585;6416.711247993851;4669.369635099286;5749.9712501437225;6008.768202518473;6193.256809182927;6319.873602527924;5052.545270925634;6158.907616385758;6373.546184719009;6396.648184349812;6436.871262574816;5222.791088356423;5245.632805703564;5802.767889284381;5940.940590594038;6094.603850749687;5332.9067541154745;6061.6056657620875;6062.42406971337;6081.209442772411;6086.573939824169;5816.94183058164;5909.320428150646;6010.248718910137;6394.200724909387;6506.577072490273;3793.696504279596;3830.272248272819;4092.304308267542;4094.61101195386;4158.293090174617;5223.843284701465;5779.682117483579;6322.652254125883;6330.366963303817;6342.778002769881;5306.416294207557;5596;5899;6072.605280656743;6113.205283313141;5042.596592272536;5062.696238225718;5467.043267428105;5987.13186587951;6077.787277445268;5628.015097358028;5724.771009159587;5943.554233432424;6007.219061521974;6023.48800351975;4394.868153955386;5696.259486266758;5859.824205273849;5904.822855314347;6032.3967603239325;5222.503862133091;5974.522038236843;5990.281166260077;6000.369961154016;6015.789447369321 11:16:11 INFO - PROCESS | 1663 | |5;yui.html;624.5690473573234;745.1505283976264;755.9659815308311;770.0605261580873;823.7611092783093;14916.77624835627;15525.534233973;15686.921565392171;15718.764218536731;15749;13940.442382304722;14171.220582867938;14205.92897035516;14714.852851471482;14792.18642974636;716.9784906452815;891.3671293381707;901.2114399900088;925.4771054354268;928.2898582584328;922.861570764384;932.5104320231865;933.0715937642055;934.4066517761203;934.5981228071927;972.1445128287097;975.4829940131706;984.6061575369873;989.1641562879355;989.366805244644;937.3719607862714;955.4888134847857;976.3995142987012;978.6574698855414;980.3186785184299;704.5244459989486;728.6101935464554;732.1836152689713;735.6468894930409;739.2939742545856;15185.392584296615;15224;15346.846531534653;15713.607159820982;15852.52442426729;11912.583059592873;12158.5744498943;14876.851231487655;15107.54677359681;15134.848651513565;8952.597133129026;12213.877861221363;12339;12584.433700483409;12690.42893069814;3908.5895980922164;3979.761214327121;3983.48214732083;3992.800359982018;4015.1768887378016;130179;130814.34592827165;131872;132002;133057;10087.445190514445;11616.535338586362;11679.532818687157;11734.11994100446;11939.820902686466;19925.402237932885;23880.40298992539;24346.63480047801;24357.51284974326;24424;8198;8330.791730206793;8485.0666426693;8522.957385213034;8536.957315213383;4342.6308763754805;4364.738115713068;4381.461215329151;4408.0071325042145;4436.889077773081;3649.543807024122;3703.8333275002688;3711.31340701971;3813.7711737295294;3819.732618716663;670.8255853478131;671.6272468779777;672.4788289076005;678.4267294136447;687.4088284075691;631.9273283572356;684.8938414545753;705.6083873450284;712.8431745016088;717.4977515739004;9340.579673914553;9621.749172607657;9680.56437460316;9764.218862491125;9781.559829807677;602.8523011862122;641.9261784894703;643.5752403413725;691.7578847403469;697.5431092634333;4639.303606465947;4732.5977291929885;4740.620750339965;4773.451053128865;4888.682235654742;110399;139458;139862.30068849592;164145.17927410526;164603.3539664588;139491;140091;141409;141424;142083;70506.2373440668;96976;101907.98092018985;106791;106964.46517767361;8541.188587084218;9016.954915225382;9031.142041506046;9047.281016606823;9225.261979041794;58560.12159817521;61190.38809611847;62046;64418.677906610166;66812.99561013178;73685;86150;94650;95164.52417737867;97793.51103244438;12376.876231237933;12393.132480726263;12394.690132746753;12411.937940310241;12551.121421500407;13586.252756098509;14028.088174269049;14222.502212422516;14364.497242596459;14440.927795360956;12518.311492867979;12825.358732063547;13090.803637945248;13247;13293.468261269827;12782.36088195568;12791.872081279069;13025.934870325587;13435.462581496631;13450.529231476852;12348.81476777831;12685.556005539762;12743.553975610808;12860.485580577046;12930.030247731645;10729.892701073202;10924.890751092387;11396.601118961129;11519.19365644397;11769.764604708029;9688.46713430768;9788.412695238309;10096.747581310527;10327.277090603586;10387.272890897866 11:16:11 INFO - PROCESS | 1663 | __end_tp_report 11:16:11 INFO - PROCESS | 1663 | __start_cc_report 11:16:11 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,435 11:16:11 INFO - PROCESS | 1663 | __end_cc_report 11:16:11 INFO - PROCESS | 1663 | __startTimestamp1468433771321__endTimestamp 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | ------- Summary: start ------- 11:16:11 INFO - PROCESS | 1663 | Number of tests: 6 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5774.26 Median:6106.82 stddev:821.24 (13.4%) stddev-sans-first:802.66 11:16:11 INFO - PROCESS | 1663 | Values: 3416.3 3431.3 3456.9 3474.6 3475.8 5838.1 5904.2 5905.2 5917.3 5937.5 5699.4 5808.6 5853.8 5869.9 5937.9 5309.5 5342.8 5380.7 5417.7 5444.2 227.7 5385.5 5397.0 5413.2 5434.9 4307.8 4404.8 5276.1 5329.5 5333.8 4590.4 5130.0 5283.5 5328.8 5339.0 4610.0 5265.8 5291.5 5296.5 5336.1 4230.5 5745.6 5893.6 5916.4 6010.8 6121.5 6240.4 6249.8 6301.7 6308.1 5291.7 6237.8 6321.0 6332.8 6337.1 5994.5 6008.8 6009.2 6032.7 6035.8 6301.5 6385.3 6411.9 6452.6 6487.2 6263.5 6278.9 6280.3 6297.4 6305.2 6318.6 6321.1 6359.2 6362.0 6379.0 6174.8 6207.8 6248.3 6267.9 6302.9 6151.8 6190.3 6257.8 6267.9 6296.5 4958.1 5008.1 5011.7 5016.8 5022.8 4445.0 4492.1 4530.0 4543.6 4622.4 4560.5 5949.0 6018.2 6051.5 6115.4 6275.5 6354.7 6356.4 6359.0 6374.0 5891.0 6090.7 6106.8 6132.9 6133.5 5114.2 5188.5 5577.8 5590.2 5613.2 6533.1 6572.2 6573.5 6581.7 6597.5 6238.4 6253.2 6303.3 6336.7 6346.9 5546.7 6411.7 6553.9 6557.0 6626.8 6274.2 6290.6 6316.2 6334.3 6337.8 6223.9 6231.4 6237.2 6331.3 6333.6 6230.9 6235.5 6247.3 6249.5 6305.7 5301.6 6215.3 6236.8 6255.7 6290.7 4952.9 5561.4 5873.9 5880.5 6079.5 5310.4 6066.0 6114.8 6148.4 6182.8 6022.8 6128.2 6128.8 6139.8 6152.8 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:69268.16 Median:39691.70 stddev:155075.64 (390.7%) stddev-sans-first:155424.67 11:16:11 INFO - PROCESS | 1663 | Values: 482.3 509.9 524.5 562.6 582.2 29078.7 37932.1 39735.8 39820.0 39833.6 41131.6 41759.8 41786.8 41833.8 41936.4 9390.8 9633.9 9667.0 9670.1 9692.3 9413.4 9437.1 9479.3 9506.9 9595.0 9457.0 9564.3 9622.8 9633.6 9665.7 9540.0 9563.9 9611.9 9615.5 9628.5 9508.5 9527.5 9540.0 9542.3 9638.8 39555.8 39647.6 39857.4 39952.8 40029.6 2775.3 3088.5 3315.8 3351.8 3558.7 31537.5 31805.0 32046.8 32812.0 32972.8 3135.1 3156.7 3170.4 3177.3 3278.3 478885.0 486568.0 488961.0 489617.0 492077.5 33361.0 33946.3 34052.7 34230.0 34257.5 34819.3 35461.3 35766.6 35842.8 35857.8 14482.6 14483.3 14499.2 14668.5 14674.2 12256.4 12404.9 12442.6 12495.6 12501.0 7700.6 7718.3 7745.5 7778.7 7779.6 2796.6 3203.9 3230.2 3243.3 3273.6 988.2 989.3 1003.4 1046.3 1112.7 31135.4 31144.7 31168.0 31184.0 31792.7 998.7 1054.1 1067.2 1084.2 1101.0 12504.7 16509.4 16555.0 16558.0 16877.4 654647.0 656939.0 666632.0 667522.7 668037.0 60544.7 62343.0 62561.0 62578.0 62750.1 1361.8 1363.0 1382.3 1388.1 1391.4 30127.7 30968.8 31375.5 31391.0 31855.7 52972.7 53533.5 53923.0 54042.5 54085.7 562278.0 572000.0 573953.0 577418.1 581500.0 27618.6 27673.7 28028.7 28119.2 28253.7 50312.7 50740.0 50908.0 51364.7 51789.7 34674.3 36990.8 39867.2 41530.0 41900.8 41224.6 41508.4 41638.8 41959.4 42307.0 32781.8 39020.2 39191.8 39922.4 40218.0 33654.5 33957.0 35843.5 36323.7 36610.8 25034.2 26468.5 26493.3 26739.0 26894.5 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34969.54 Median:12941.48 stddev:97050.06 (749.9%) stddev-sans-first:97287.52 11:16:11 INFO - PROCESS | 1663 | Values: 358.7 386.9 397.3 405.3 417.5 20801.0 22007.9 23408.2 23434.3 23495.2 22158.8 22455.8 22657.0 22805.4 22875.3 5952.0 6169.3 6215.6 6228.0 6248.6 4283.3 6077.4 6603.2 6743.7 6957.4 5807.9 6178.4 6979.4 6982.7 6985.2 6112.8 6160.7 6170.2 6228.5 6245.3 5921.1 5960.8 6021.3 6026.9 6097.7 14059.0 14158.8 14196.6 22653.8 28076.3 2097.6 2194.6 2387.8 2445.4 2505.6 10856.7 11691.7 12695.4 15628.8 17106.0 1903.6 1938.7 1982.2 2010.4 2016.4 123660.4 123762.0 126502.0 127946.4 129756.0 11566.7 11865.8 11895.6 11940.0 12031.6 15099.8 15111.0 15122.4 15168.7 15170.2 8673.7 8743.7 8753.7 8767.6 8869.0 8672.4 8716.2 8743.5 8793.9 8803.4 4266.4 4645.8 4664.0 4688.0 4701.5 1808.4 1824.7 1870.3 1970.9 2052.9 786.6 870.8 918.9 945.7 986.8 18960.1 19778.3 22212.6 22739.3 22785.3 756.9 962.4 963.7 974.3 1030.0 9442.7 11003.7 11076.0 11778.1 12069.0 561415.0 581877.0 582070.0 585601.0 591285.0 95926.0 98129.0 99005.0 133373.0 141102.0 864.7 1019.9 1067.4 1081.5 1090.8 19989.2 20106.2 20253.9 20313.6 20318.3 53619.7 57154.6 57309.4 57446.0 57892.7 85949.0 86361.6 86622.6 87633.6 88363.6 5612.8 6393.9 8151.0 8372.0 8774.0 9735.0 11883.9 13642.7 13899.5 13972.5 11466.5 11467.4 11497.3 11854.8 11986.3 11171.3 11536.7 11631.7 11951.0 11990.3 11427.5 11855.5 12010.1 12050.4 12081.5 7293.9 7855.1 8475.1 8572.6 8709.9 11242.5 11889.8 12006.5 12048.8 12069.3 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5883.77 Median:4799.18 stddev:3342.49 (69.6%) stddev-sans-first:3336.18 11:16:11 INFO - PROCESS | 1663 | Values: 1573.7 1605.2 1865.7 1936.5 1939.9 8330.7 8937.8 9009.4 9469.0 9519.2 8922.0 8989.5 9053.0 9207.1 9232.1 2409.5 2440.6 2443.5 2448.2 2450.4 2421.7 2426.1 2452.5 2465.5 2471.7 2437.6 2438.1 2439.6 2447.4 2474.3 2002.2 2411.1 2420.1 2424.6 2426.3 2163.8 2253.2 2397.7 2410.9 2418.2 7653.7 9263.5 9318.0 9324.9 9343.5 5471.2 5488.2 5539.2 5560.3 5650.4 3645.5 3716.7 3762.7 3798.7 3805.2 1083.1 1115.3 1129.3 1141.4 1493.8 10037.3 12051.8 12215.6 12527.4 12571.5 3986.8 4563.3 4706.5 4795.6 4802.8 9433.3 9522.8 9607.0 9629.2 9629.5 5340.8 5378.8 5421.0 5436.5 5449.9 4537.4 4850.6 4854.1 5004.8 5044.5 3902.0 3925.6 4001.6 4009.0 4030.2 1203.6 1206.0 1208.4 1213.7 1215.9 927.1 930.2 936.4 947.4 985.3 5990.6 6058.6 6151.6 6194.3 6231.9 369.8 448.4 458.5 458.5 466.1 3987.6 4085.1 4152.2 4153.2 4190.5 11059.2 11074.3 11358.9 11512.2 11518.0 11195.0 11373.0 11412.1 11412.7 11425.0 8453.9 8542.7 8649.6 8665.7 8672.9 6044.1 6115.8 6119.5 6178.2 6195.6 10026.8 10083.1 10168.2 10194.1 10461.3 10419.5 10594.0 10719.1 10721.2 10758.8 6606.2 7234.2 7313.7 7315.6 7396.2 8654.9 8783.9 8826.9 8886.4 8891.6 7667.2 7740.2 7868.3 7903.2 7922.5 7644.1 7720.1 7749.3 7854.5 7859.3 7141.5 7223.0 7259.5 7319.9 7396.5 5164.2 5190.0 5219.9 5292.8 5356.7 4271.3 5120.7 5199.1 5270.9 5362.6 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4788.53 Median:5367.05 stddev:1490.81 (27.8%) stddev-sans-first:1456.71 11:16:11 INFO - PROCESS | 1663 | Values: 316.1 323.3 323.6 328.7 332.3 4949.8 5602.2 5724.8 5756.6 5766.7 4270.4 4603.9 5635.6 5650.0 5694.7 4086.9 4167.4 4292.4 4326.4 4328.4 4248.0 4312.5 4334.6 4335.0 4356.6 3678.7 4287.7 4298.2 4311.6 4317.8 3235.0 3995.6 4235.5 4252.6 4252.8 3640.2 3648.8 3663.4 3665.9 3668.5 5231.2 5369.7 5535.7 5561.6 5617.7 4070.8 4353.0 4626.6 4893.0 4898.8 5148.9 5961.9 5969.5 5981.5 6032.3 4015.0 4029.1 4034.2 4041.5 4042.5 5164.8 5364.4 5441.6 5468.0 6417.6 3391.7 4016.8 4080.3 4101.8 4104.6 3650.3 4172.7 4173.8 4176.4 4183.2 4675.6 4857.3 4882.8 4909.5 4927.5 4946.8 5504.9 5978.3 6036.6 6047.7 1188.7 1391.5 1410.1 1420.6 1422.9 751.7 762.5 824.2 852.0 903.7 5091.4 5519.5 5528.8 5563.9 5600.8 5811.7 6078.4 6127.4 6141.0 6147.7 5280.5 5499.2 5551.8 5570.5 5617.6 3218.8 3231.3 3231.5 3231.8 3235.1 5967.4 6356.5 6360.5 6378.4 6416.7 4669.4 5750.0 6008.8 6193.3 6319.9 5052.5 6158.9 6373.5 6396.6 6436.9 5222.8 5245.6 5802.8 5940.9 6094.6 5332.9 6061.6 6062.4 6081.2 6086.6 5816.9 5909.3 6010.2 6394.2 6506.6 3793.7 3830.3 4092.3 4094.6 4158.3 5223.8 5779.7 6322.7 6330.4 6342.8 5306.4 5596.0 5899.0 6072.6 6113.2 5042.6 5062.7 5467.0 5987.1 6077.8 5628.0 5724.8 5943.6 6007.2 6023.5 4394.9 5696.3 5859.8 5904.8 6032.4 5222.5 5974.5 5990.3 6000.4 6015.8 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:25234.90 Median:3944.18 stddev:40916.18 (1037.4%) stddev-sans-first:40989.23 11:16:11 INFO - PROCESS | 1663 | Values: 624.6 745.2 756.0 770.1 823.8 14916.8 15525.5 15686.9 15718.8 15749.0 13940.4 14171.2 14205.9 14714.9 14792.2 717.0 891.4 901.2 925.5 928.3 922.9 932.5 933.1 934.4 934.6 972.1 975.5 984.6 989.2 989.4 937.4 955.5 976.4 978.7 980.3 704.5 728.6 732.2 735.6 739.3 15185.4 15224.0 15346.8 15713.6 15852.5 11912.6 12158.6 14876.9 15107.5 15134.8 8952.6 12213.9 12339.0 12584.4 12690.4 3908.6 3979.8 3983.5 3992.8 4015.2 130179.0 130814.3 131872.0 132002.0 133057.0 10087.4 11616.5 11679.5 11734.1 11939.8 19925.4 23880.4 24346.6 24357.5 24424.0 8198.0 8330.8 8485.1 8523.0 8537.0 4342.6 4364.7 4381.5 4408.0 4436.9 3649.5 3703.8 3711.3 3813.8 3819.7 670.8 671.6 672.5 678.4 687.4 631.9 684.9 705.6 712.8 717.5 9340.6 9621.7 9680.6 9764.2 9781.6 602.9 641.9 643.6 691.8 697.5 4639.3 4732.6 4740.6 4773.5 4888.7 110399.0 139458.0 139862.3 164145.2 164603.4 139491.0 140091.0 141409.0 141424.0 142083.0 70506.2 96976.0 101908.0 106791.0 106964.5 8541.2 9017.0 9031.1 9047.3 9225.3 58560.1 61190.4 62046.0 64418.7 66813.0 73685.0 86150.0 94650.0 95164.5 97793.5 12376.9 12393.1 12394.7 12411.9 12551.1 13586.3 14028.1 14222.5 14364.5 14440.9 12518.3 12825.4 13090.8 13247.0 13293.5 12782.4 12791.9 13025.9 13435.5 13450.5 12348.8 12685.6 12743.6 12860.5 12930.0 10729.9 10924.9 11396.6 11519.2 11769.8 9688.5 9788.4 10096.7 10327.3 10387.3 11:16:11 INFO - PROCESS | 1663 | -------- Summary: end -------- 11:16:11 INFO - PROCESS | 1663 | 11:16:11 INFO - TEST-INFO | 1663: exit 0 11:16:11 INFO - TEST-OK | dromaeo_css | took 1112707ms 11:16:11 INFO - TEST-START | kraken 11:16:11 INFO - operating with platform_type : mac_ 11:16:11 INFO - Initialising browser for kraken test... 11:16:11 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmppLb4JJ/profile http://localhost:49280/getInfo.html) 11:16:14 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 11:16:14 INFO - PROCESS | 1671 | colorDepth:24 11:16:14 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 11:16:14 INFO - PROCESS | 1671 | __metrics 11:16:14 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:16:15 INFO - TEST-INFO | 1671: exit 0 11:16:15 INFO - Browser initialized. 11:16:15 INFO - Running cycle 1/1 for kraken test... 11:16:15 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/T/tmppLb4JJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:27 INFO - PROCESS | 1673 | RSS: Main: 254140416 11:16:27 INFO - PROCESS | 1673 | 11:16:30 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:31 INFO - PROCESS | 1673 | RSS: Main: 267067392 11:16:31 INFO - PROCESS | 1673 | 11:16:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 11:16:34 INFO - PROCESS | 1673 | RSS: Main: 271175680 11:16:34 INFO - PROCESS | 1673 | 11:16:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 11:16:38 INFO - PROCESS | 1673 | RSS: Main: 271724544 11:16:38 INFO - PROCESS | 1673 | 11:16:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 11:16:41 INFO - PROCESS | 1673 | RSS: Main: 272777216 11:16:41 INFO - PROCESS | 1673 | 11:16:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:43 INFO - PROCESS | 1673 | RSS: Main: 273473536 11:16:43 INFO - PROCESS | 1673 | 11:16:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:47 INFO - PROCESS | 1673 | RSS: Main: 274063360 11:16:47 INFO - PROCESS | 1673 | 11:16:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:50 INFO - PROCESS | 1673 | RSS: Main: 274219008 11:16:50 INFO - PROCESS | 1673 | 11:16:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 11:16:54 INFO - PROCESS | 1673 | RSS: Main: 274481152 11:16:54 INFO - PROCESS | 1673 | 11:16:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:56 INFO - PROCESS | 1673 | RSS: Main: 273887232 11:16:56 INFO - PROCESS | 1673 | 11:16:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:59 INFO - PROCESS | 1673 | RSS: Main: 273874944 11:16:59 INFO - PROCESS | 1673 | 11:17:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:02 INFO - PROCESS | 1673 | RSS: Main: 274173952 11:17:02 INFO - PROCESS | 1673 | 11:17:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:05 INFO - PROCESS | 1673 | RSS: Main: 274341888 11:17:05 INFO - PROCESS | 1673 | 11:17:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:09 INFO - PROCESS | 1673 | RSS: Main: 274513920 11:17:09 INFO - PROCESS | 1673 | 11:17:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 11:17:11 INFO - PROCESS | 1673 | RSS: Main: 275423232 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | __start_tp_report 11:17:11 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 11:17:11 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 11:17:11 INFO - PROCESS | 1673 | |i|pagename|runs| 11:17:11 INFO - PROCESS | 1673 | |0;ai-astar;104;118;107;114;117;118;130;169;163;115 11:17:11 INFO - PROCESS | 1673 | |1;audio-beat-detection;141;115;175;173;124;155;158;108;154;108 11:17:11 INFO - PROCESS | 1673 | |2;audio-dft;196;198;218;223;266;269;196;229;257;199 11:17:11 INFO - PROCESS | 1673 | |3;audio-fft;73;84;76;133;59;57;57;60;140;61 11:17:11 INFO - PROCESS | 1673 | |4;audio-oscillator;69;71;121;72;71;73;114;65;95;147 11:17:11 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;86;86;87;84;88;85;105;130;110;84 11:17:11 INFO - PROCESS | 1673 | |6;imaging-darkroom;96;96;94;96;91;117;140;106;150;115 11:17:11 INFO - PROCESS | 1673 | |7;imaging-desaturate;92;92;78;141;138;87;87;89;89;149 11:17:11 INFO - PROCESS | 1673 | |8;json-parse-financial;57;55;58;57;56;57;56;56;58;57 11:17:11 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;66;78;60;77;95;120;113;88;73;70 11:17:11 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;86;80;87;83;89;88;83;85;87;85 11:17:11 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;138;141;167;145;136;151;126;151;197;146 11:17:11 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;182;164;163;162;165;158;165;160;231;175 11:17:11 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;68;65;65;66;66;63;63;60;76;85 11:17:11 INFO - PROCESS | 1673 | __end_tp_report 11:17:11 INFO - PROCESS | 1673 | __start_cc_report 11:17:11 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1122 11:17:11 INFO - PROCESS | 1673 | __end_cc_report 11:17:11 INFO - PROCESS | 1673 | __startTimestamp1468433831237__endTimestamp 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | ------- Summary: start ------- 11:17:11 INFO - PROCESS | 1673 | Number of tests: 14 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:125.50 Median:118.00 stddev:22.49 (19.1%) stddev-sans-first:22.46 11:17:11 INFO - PROCESS | 1673 | Values: 104.0 118.0 107.0 114.0 117.0 118.0 130.0 169.0 163.0 115.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:154.50 stddev:25.77 (16.7%) stddev-sans-first:27.33 11:17:11 INFO - PROCESS | 1673 | Values: 141.0 115.0 175.0 173.0 124.0 155.0 158.0 108.0 154.0 108.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:225.10 Median:226.00 stddev:29.43 (13.0%) stddev-sans-first:29.27 11:17:11 INFO - PROCESS | 1673 | Values: 196.0 198.0 218.0 223.0 266.0 269.0 196.0 229.0 257.0 199.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:80.00 Median:60.50 stddev:31.18 (51.5%) stddev-sans-first:32.97 11:17:11 INFO - PROCESS | 1673 | Values: 73.0 84.0 76.0 133.0 59.0 57.0 57.0 60.0 140.0 61.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:71.00 stddev:28.31 (39.9%) stddev-sans-first:29.01 11:17:11 INFO - PROCESS | 1673 | Values: 69.0 71.0 121.0 72.0 71.0 73.0 114.0 65.0 95.0 147.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:85.50 stddev:15.51 (18.1%) stddev-sans-first:16.14 11:17:11 INFO - PROCESS | 1673 | Values: 86.0 86.0 87.0 84.0 88.0 85.0 105.0 130.0 110.0 84.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:110.10 Median:92.50 stddev:20.53 (22.2%) stddev-sans-first:21.14 11:17:11 INFO - PROCESS | 1673 | Values: 96.0 96.0 94.0 96.0 91.0 117.0 140.0 106.0 150.0 115.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:88.00 stddev:26.96 (30.6%) stddev-sans-first:28.23 11:17:11 INFO - PROCESS | 1673 | Values: 92.0 92.0 78.0 141.0 138.0 87.0 87.0 89.0 89.0 149.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 11:17:11 INFO - PROCESS | 1673 | Values: 57.0 55.0 58.0 57.0 56.0 57.0 56.0 56.0 58.0 57.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:84.00 Median:75.00 stddev:19.93 (26.6%) stddev-sans-first:20.05 11:17:11 INFO - PROCESS | 1673 | Values: 66.0 78.0 60.0 77.0 95.0 120.0 113.0 88.0 73.0 70.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.50 stddev:2.71 (3.1%) stddev-sans-first:2.86 11:17:11 INFO - PROCESS | 1673 | Values: 86.0 80.0 87.0 83.0 89.0 88.0 83.0 85.0 87.0 85.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:148.50 stddev:19.83 (13.4%) stddev-sans-first:20.56 11:17:11 INFO - PROCESS | 1673 | Values: 138.0 141.0 167.0 145.0 136.0 151.0 126.0 151.0 197.0 146.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:165.00 stddev:21.78 (13.2%) stddev-sans-first:22.83 11:17:11 INFO - PROCESS | 1673 | Values: 182.0 164.0 163.0 162.0 165.0 158.0 165.0 160.0 231.0 175.0 11:17:11 INFO - PROCESS | 1673 | 11:17:11 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:66.00 stddev:7.39 (11.2%) stddev-sans-first:7.84 11:17:11 INFO - PROCESS | 1673 | Values: 68.0 65.0 65.0 66.0 66.0 63.0 63.0 60.0 76.0 85.0 11:17:11 INFO - PROCESS | 1673 | -------- Summary: end -------- 11:17:11 INFO - PROCESS | 1673 | 11:17:12 INFO - TEST-INFO | 1673: exit 0 11:17:12 INFO - TEST-OK | kraken | took 60270ms 11:17:12 INFO - SUITE-END | took 1172s 11:17:12 INFO - Completed test suite (00:19:33) 11:17:12 INFO - javascript benchmark 11:17:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7425.791248223652, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.2996585699934, 3431.3137372525503, 3456.879009234677, 3474.6177920428754, 3475.766103033423, 5838.065909454488, 5904.232449781533, 5905.173275741399, 5917.260342457193, 5937.524998000161, 5699.401562835895, 5808.56435767317, 5853.76584936602, 5869.8826023479505, 5937.940620593793, 5309.548688361494, 5342.839714808542, 5380.7309634518315, 5417.674939503623, 5444.183372494138, 227.67778193127947, 5385.542228910547, 5396.973015134919, 5413.242146099549, 5434.945650543484, 4307.806148723315, 4404.823807047715, 5276.12943864262, 5329.467053294678, 5333.786648534054, 4590.380298659705, 5130.025295193901, 5283.524482796528, 5328.786848526093, 5339.0, 4610.0, 5265.842024739264, 5291.497307755757, 5296.523312901819, 5336.066188417011, 4230.49234091911, 5745.626534275259, 5893.616914900518, 5916.378780228057, 6010.78962236324, 6121.479674227696, 6240.375962403768, 6249.781257656005, 6301.68491575424, 6308.148399965991, 5291.656042357235, 6237.844053898689, 6321.0, 6332.810015699536, 6337.112804207414, 5994.520438364921, 6008.75964961401, 6009.218801555813, 6032.728527216286, 6035.758569657252, 6301.464375528131, 6385.297617262097, 6411.903821442682, 6452.645104519296, 6487.18910136233, 6263.530235232376, 6278.937210627927, 6280.340564240781, 6297.433231009231, 6305.243370795442, 6318.557700960889, 6321.083442900754, 6359.17330747, 6362.045693145972, 6378.968105159537, 6174.8147555573405, 6207.81376558704, 6248.343923887926, 6267.9373206267355, 6302.873942521124, 6151.7539298428455, 6190.288116866618, 6257.812265632038, 6267.9373206267355, 6296.496280297565, 4958.107540642647, 5008.098542262428, 5011.699298042129, 5016.824411145592, 5022.84931452057, 4444.955550444519, 4492.124035813051, 4529.954700452953, 4543.636509079266, 4622.445306563234, 4560.498345182027, 5948.988671925783, 6018.247719035121, 6051.546134039964, 6115.449609535074, 6275.466585340298, 6354.682265886687, 6356.364363563699, 6359.046143078575, 6374.043893416025, 5890.970545147246, 6090.725917333731, 6106.816795496054, 6132.8773424532155, 6133.539984501181, 5114.207297868762, 5188.455212202664, 5577.832665020056, 5590.217369568264, 5613.158026296007, 6533.052707357407, 6572.244191917895, 6573.506986975996, 6581.6709164542535, 6597.472202223715, 6238.407351301619, 6253.218347706536, 6303.338149494421, 6336.651484168415, 6346.873062538631, 5546.668799488174, 6411.679416029273, 6553.901691474727, 6557.0, 6626.768063117768, 6274.215723034621, 6290.591111577733, 6316.178896743394, 6334.303226645157, 6337.7781777637565, 6223.906641400473, 6231.40801623845, 6237.220347456568, 6331.303556608861, 6333.58831675958, 6230.937690623217, 6235.501159907106, 6247.312795592572, 6249.531285153541, 6305.747770089145, 5301.602379821606, 6215.316315205233, 6236.75052997875, 6255.749770009149, 6290.685465726787, 4952.925706114484, 5561.388247292875, 5873.9412605873395, 5880.470757631833, 6079.483243924139, 5310.362756469249, 6065.999110146777, 6114.814446323713, 6148.415900489446, 6182.845428864314, 6022.789202377896, 6128.1726966858905, 6128.754849805958, 6139.8465038372615, 6152.753889844356], "value": 5725.846779156665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.2838085443114, 509.9056674515215, 524.5436470270865, 562.5527705474148, 582.1936617784368, 29078.709212907863, 37932.051698707546, 39735.80132099343, 39820.0, 39833.60166398343, 41131.58868411322, 41759.79120104403, 41786.7910660447, 41833.7908310458, 41936.370954435704, 9390.765230869249, 9633.855492167588, 9666.951665241664, 9670.081342272473, 9692.321537492378, 9413.435193888388, 9437.056294370577, 9479.289053320994, 9506.904930950706, 9595.0, 9456.952715236413, 9564.330496865223, 9622.80754384912, 9633.61465541381, 9665.661701840438, 9539.952300238489, 9563.856542151872, 9611.903880961207, 9615.471149086798, 9628.518574071268, 9508.524573771352, 9527.52362381878, 9540.045995400475, 9542.284328675378, 9638.807223855554, 39555.80222098871, 39647.60352396468, 39857.40213896794, 39952.80141595757, 40029.59970400288, 2775.278427608816, 3088.521279201705, 3315.8176300303476, 3351.798892066484, 3558.679718825292, 31537.526937095732, 31805.0, 32046.839765801255, 32812.0, 32972.83513582441, 3135.0751528299206, 3156.71589556941, 3170.381775553768, 3177.269228077555, 3278.2623909620384, 478885.0, 486568.0, 488961.0, 489617.0, 492077.53961230326, 33361.0, 33946.32107357839, 34052.65947340495, 34230.0, 34257.48613770796, 34819.30361392758, 35461.290774184374, 35766.64233357633, 35842.82078589642, 35857.82071089628, 14482.565523034325, 14483.275836208148, 14499.202543859978, 14668.486602968846, 14674.192919389323, 12256.448459819152, 12404.875951240552, 12442.626721198378, 12495.562655307021, 12501.0, 7700.614969251515, 7718.343940764986, 7745.496542724705, 7778.727744528915, 7779.560781255486, 2796.566532187514, 3203.8878639247514, 3230.208598893239, 3243.31890303039, 3273.607167139911, 988.1650005745134, 989.292655751127, 1003.4029752297372, 1046.3094357723867, 1112.7273817914663, 31135.377292454024, 31144.688553114633, 31168.0, 31184.0, 31792.68207317897, 998.6604554451521, 1054.082947835388, 1067.2262609607972, 1084.2464487181492, 1100.9889901101046, 12504.687382815502, 16509.422170223985, 16555.0, 16558.0, 16877.40929067477, 654647.0, 656939.0, 666632.0, 667522.6623866947, 668037.0, 60544.69727651333, 62343.0, 62561.0, 62578.0, 62750.0587491188, 1361.8025386318927, 1363.0050063453734, 1382.322661895664, 1388.1185447241076, 1391.4016972701836, 30127.698723013367, 30968.845155774077, 31375.529367059054, 31391.0, 31855.681443185273, 52972.735136324074, 53533.46466535285, 53923.0, 54042.459575403744, 54085.72957135189, 562278.0, 572000.0, 573953.0, 577418.1129094327, 581500.0, 27618.5857212146, 27673.723262767115, 28028.719712803428, 28119.156425307272, 28253.728582214262, 50312.74843625905, 50739.98520029505, 50907.981840363725, 51364.74317628388, 51789.74105129601, 34674.306513870084, 36990.815045924595, 39867.20597573058, 41530.0, 41900.790496047324, 41224.587754122076, 41508.377374340016, 41638.791806040776, 41959.370609441496, 42307.0, 32781.83609081939, 39020.2195956085, 39191.824245272684, 39922.40116398198, 40218.0, 33654.49518257277, 33957.0, 35843.46234806428, 36323.72866949644, 36610.8169459151, 25034.24897253085, 26468.470630586897, 26493.33766655849, 26739.0, 26894.462110758068], "value": 18644.15959034072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6592736899945, 386.9438931354954, 397.26704230694367, 405.266467693475, 417.48857649379516, 20801.0, 22007.889960550216, 23408.180713675025, 23434.296971090873, 23495.177668781576, 22158.778412215914, 22455.775442245573, 22657.0, 22805.4298642534, 22875.313740587768, 5951.970240148804, 6169.290531588857, 6215.56491045627, 6227.968860155693, 6248.562600617958, 4283.336082907154, 6077.361877002917, 6603.240627327847, 6743.651269746046, 6957.373836354727, 5807.854803629901, 6178.413050760193, 6979.371856532911, 6982.720691172372, 6985.161780586312, 6112.816615501542, 6160.6611636359985, 6170.228721409824, 6228.501719862423, 6245.344238854923, 5921.111833225008, 5960.821175364746, 6021.277446706379, 6026.9095963560585, 6097.664628445434, 14059.015868889182, 14158.787618185735, 14196.645083872883, 22653.77346226533, 28076.29809254785, 2097.6014557234075, 2194.594000109985, 2387.77316154965, 2445.3886528367907, 2505.5615267328326, 10856.728581785439, 11691.7077073073, 12695.428705708266, 15628.843711562853, 17105.973641581546, 1903.6383087213524, 1938.709193620954, 1982.2269314967175, 2010.3767831971988, 2016.3749237736201, 123660.38169809093, 123762.0, 126502.0, 127946.36026819807, 129756.0, 11566.65300041, 11865.762684746256, 11895.583654572049, 11940.0, 12031.578894738817, 15099.849001509845, 15111.0, 15122.39510419593, 15168.696626067416, 15170.24148792556, 8673.6530538779, 8743.737687869374, 8753.693620723372, 8767.561621918878, 8869.0, 8672.436291641023, 8716.171963663443, 8743.519106449206, 8793.91206087931, 8803.383763136648, 4266.402703621496, 4645.814167433333, 4664.0, 4688.0, 4701.506341834127, 1808.367071524982, 1824.6511259118447, 1870.326682394337, 1970.9455441338814, 2052.8563000589816, 786.622421237809, 870.8388948044632, 918.8897332320031, 945.7115579748105, 986.8059647826067, 18960.051997400074, 19778.30775922836, 22212.555748884934, 22739.317820465414, 22785.316440506813, 756.9243075692386, 962.41292811385, 963.7377477239455, 974.3277138774223, 1029.9957541397227, 9442.678025076495, 11003.724906877393, 11076.003159715665, 11778.116641251769, 12069.0, 561415.0, 581877.0, 582070.0, 585601.0, 591285.0, 95926.0, 98129.0, 99005.00994989958, 133373.0, 141102.0, 864.7103220421229, 1019.9439030853226, 1067.412922892406, 1081.4808891732014, 1090.7600327927844, 19989.200431982557, 20106.195752169748, 20253.898730506255, 20313.593728125652, 20318.288859890425, 53619.731901340245, 57154.57113572194, 57309.42690573041, 57446.0, 57892.710536448736, 85949.0, 86361.56819215864, 86622.56688716516, 87633.56183219043, 88363.55818221124, 5612.803551875665, 6393.87212255743, 8150.959245203736, 8371.95814020926, 8773.956130219309, 9734.951325243328, 11883.940580297043, 13642.727145457235, 13899.513517026855, 13972.510962116683, 11466.484008219484, 11467.4266286687, 11497.252678575866, 11854.822177667169, 11986.340751258416, 11171.329720216812, 11536.711582210512, 11631.709207269885, 11951.0, 11990.340531270864, 11427.542898283975, 11855.525778968744, 12010.099242557018, 12050.397480126134, 12081.456334465145, 7293.890591641236, 7855.096663883498, 8475.067742548192, 8572.571371431528, 8709.911261092364, 11242.494087765906, 11889.762204756029, 12006.459709313276, 12048.75902481928, 12069.27584344942], "value": 9882.00231110814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.7482002879542, 1605.2134454117481, 1865.6641804475198, 1936.5061909213148, 1939.883606983581, 8330.66709326508, 8937.821243575125, 9009.414388064779, 9468.99999999999, 9519.190868776153, 8921.95539022304, 8989.460632362046, 9052.958909725383, 9207.07929207079, 9232.122948319915, 2409.4578719788037, 2440.5973014452684, 2443.535728211643, 2448.2288079254977, 2450.3506570758764, 2421.69728783902, 2426.0902161689364, 2452.472718365551, 2465.5192237513693, 2471.7404672509397, 2437.609982402816, 2438.085717855804, 2439.6462512935705, 2447.36368544178, 2474.2824580871616, 2002.2491565662876, 2411.05968672218, 2420.116657420038, 2424.612062070069, 2426.3206302235403, 2163.7511686156136, 2253.166328458481, 2397.700287464067, 2410.9397265068337, 2418.201993342193, 7653.655585498666, 9263.536823158882, 9317.953410232973, 9324.90675093254, 9343.486108264044, 5471.206675032098, 5488.231647569343, 5539.224508568804, 5560.304961879765, 5650.434956504317, 3645.453182022718, 3716.684081853046, 3762.6613604775703, 3798.715096367756, 3805.1818858945458, 1083.101026148303, 1115.275071203716, 1129.2659771148737, 1141.4121727310442, 1493.8132733408324, 10037.29738918276, 12051.819222711667, 12215.633530994084, 12527.43626536799, 12571.497140114385, 3986.7807270599815, 4563.338315944169, 4706.529347065266, 4795.568398844121, 4802.7838747255755, 9433.292503062297, 9522.761930951643, 9607.039296070338, 9629.181519570915, 9629.518524073768, 5340.75966581497, 5378.811741589026, 5421.0, 5436.537894278951, 5449.891002179934, 4537.4328208973875, 4850.6362022848425, 4854.126257273725, 5004.774785134678, 5044.470330615306, 3901.96098039016, 3925.5878132796215, 4001.6198461146146, 4008.9799551002056, 4030.2141082488633, 1203.554684766642, 1205.9638210853689, 1208.4018410886492, 1213.6541085790507, 1215.8601760797444, 927.1192367251003, 930.1628534319032, 936.3773090894479, 947.4126041853957, 985.2708995343537, 5990.580659353804, 6058.636481811017, 6151.569390142647, 6194.318624951252, 6231.9094158522075, 369.83357489129463, 448.3812338972198, 458.52542618389805, 458.53687775346475, 466.1097304149059, 3987.5813039631003, 4085.101277718897, 4152.231837110145, 4153.190127925086, 4190.497140343178, 11059.22585419013, 11074.280171788809, 11358.886411135949, 11512.19414640967, 11518.0, 11195.0, 11373.0, 11412.087033037336, 11412.657620271239, 11425.028872545927, 8453.873191902127, 8542.701005464778, 8649.56752162402, 8665.653373864974, 8672.913270867337, 6044.0933859919605, 6115.84710382244, 6119.4798442132915, 6178.227721534809, 6195.566310358232, 10026.849597256192, 10083.14293285079, 10168.186545076229, 10194.133498652402, 10461.320014199053, 10419.479026048819, 10594.046535811814, 10719.088877445505, 10721.249512534048, 10758.784824303313, 6606.207255129415, 7234.16807067194, 7313.67088481009, 7315.597642129521, 7396.186419493959, 8654.870176947477, 8783.912160878564, 8826.91173088261, 8886.422382545372, 8891.599878005634, 7667.194944530744, 7740.225977402215, 7868.25251601097, 7903.170167132598, 7922.4850384724805, 7644.12092609357, 7720.112187098331, 7749.263819937097, 7854.450188486751, 7859.331956783737, 7141.464390170654, 7223.0, 7259.491835571459, 7319.926800731924, 7396.519226250277, 5164.1995490699, 5190.0, 5219.947800521946, 5292.788288468572, 5356.678599284055, 4271.252530807034, 5120.694222973118, 5199.116150254541, 5270.947290527046, 5362.597805164706], "value": 4637.515516593765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.08966177409064, 323.2677984365413, 323.5841943103113, 328.71073455359283, 332.31045580420636, 4949.8367883547335, 5602.2436971009, 5724.771009159639, 5756.625819321746, 5766.711664416778, 4270.444842170521, 4603.8720513474245, 5635.63368381056, 5649.971750141243, 5694.747155625766, 4086.856960006408, 4167.416561681367, 4292.377605247238, 4326.372675961984, 4328.415663885383, 4248.022954720416, 4312.547182545834, 4334.631556317717, 4334.956650433503, 4356.607905288523, 3678.742488025839, 4287.6569874410125, 4298.1517947282655, 4311.590398912098, 4317.783251477638, 3234.9648112603977, 3995.580464051262, 4235.475228917588, 4252.617264446184, 4252.766097864616, 3640.2173532690335, 3648.7810731356203, 3663.358912190356, 3665.9450108248398, 3668.5414323209598, 5231.189165679326, 5369.71126929538, 5535.6955367454775, 5561.580712390123, 5617.719114044281, 4070.75575465473, 4353.020570371641, 4626.58360747531, 4892.9755351223375, 4898.804047838083, 5148.871278218037, 5961.91057134139, 5969.462748352669, 5981.491573216282, 6032.306284777219, 4014.959850401488, 4029.1191797864667, 4034.245103380039, 4041.4948131483566, 4042.4744783178294, 5164.793408263665, 5364.383095943977, 5441.619086663935, 5467.972660136674, 6417.647029413381, 3391.6947474727394, 4016.8192431340076, 4080.326746086922, 4101.835926562963, 4104.56902025283, 3650.3064417760543, 4172.728772629769, 4173.770442625685, 4176.394422808737, 4183.163367326547, 4675.574888150686, 4857.271409288635, 4882.7558622068755, 4909.459959404463, 4927.482614325516, 4946.802127914915, 5504.862378440571, 5978.342382337939, 6036.649659439054, 6047.7278522466595, 1188.7028242939266, 1391.4503771010598, 1410.104583589428, 1420.5596265157835, 1422.8972546276718, 751.7331347371713, 762.4891322813728, 824.2128767027594, 852.0074113657644, 903.6972614174325, 5091.389033316026, 5519.530839878656, 5528.834134975958, 5563.91353242534, 5600.775968961196, 5811.738471768781, 6078.361772013964, 6127.417895300028, 6140.990914451886, 6147.66187859672, 5280.498352656491, 5499.230107784913, 5551.7799676187715, 5570.546261317928, 5617.550595952314, 3218.7585931054796, 3231.321422501301, 3231.531427942935, 3231.8060916345094, 3235.1074621346306, 5967.433093856077, 6356.4574170332235, 6360.491160707133, 6378.362163783585, 6416.711247993851, 4669.369635099286, 5749.9712501437225, 6008.768202518473, 6193.256809182927, 6319.873602527924, 5052.545270925634, 6158.907616385758, 6373.546184719009, 6396.648184349812, 6436.871262574816, 5222.791088356423, 5245.632805703564, 5802.767889284381, 5940.940590594038, 6094.603850749687, 5332.9067541154745, 6061.6056657620875, 6062.42406971337, 6081.209442772411, 6086.573939824169, 5816.94183058164, 5909.320428150646, 6010.248718910137, 6394.200724909387, 6506.577072490273, 3793.696504279596, 3830.272248272819, 4092.304308267542, 4094.61101195386, 4158.293090174617, 5223.843284701465, 5779.682117483579, 6322.652254125883, 6330.366963303817, 6342.778002769881, 5306.416294207557, 5596.0, 5899.0, 6072.605280656743, 6113.205283313141, 5042.596592272536, 5062.696238225718, 5467.043267428105, 5987.13186587951, 6077.787277445268, 5628.015097358028, 5724.771009159587, 5943.554233432424, 6007.219061521974, 6023.48800351975, 4394.868153955386, 5696.259486266758, 5859.824205273849, 5904.822855314347, 6032.3967603239325, 5222.503862133091, 5974.522038236843, 5990.281166260077, 6000.369961154016, 6015.789447369321], "value": 4305.328402466543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.5690473573234, 745.1505283976264, 755.9659815308311, 770.0605261580873, 823.7611092783093, 14916.77624835627, 15525.534233973, 15686.921565392171, 15718.764218536731, 15749.0, 13940.442382304722, 14171.220582867938, 14205.92897035516, 14714.852851471482, 14792.18642974636, 716.9784906452815, 891.3671293381707, 901.2114399900088, 925.4771054354268, 928.2898582584328, 922.861570764384, 932.5104320231865, 933.0715937642055, 934.4066517761203, 934.5981228071927, 972.1445128287097, 975.4829940131706, 984.6061575369873, 989.1641562879355, 989.366805244644, 937.3719607862714, 955.4888134847857, 976.3995142987012, 978.6574698855414, 980.3186785184299, 704.5244459989486, 728.6101935464554, 732.1836152689713, 735.6468894930409, 739.2939742545856, 15185.392584296615, 15224.0, 15346.846531534653, 15713.607159820982, 15852.52442426729, 11912.583059592873, 12158.5744498943, 14876.851231487655, 15107.54677359681, 15134.848651513565, 8952.597133129026, 12213.877861221363, 12339.0, 12584.433700483409, 12690.42893069814, 3908.5895980922164, 3979.761214327121, 3983.48214732083, 3992.800359982018, 4015.1768887378016, 130179.0, 130814.34592827165, 131872.0, 132002.0, 133057.0, 10087.445190514445, 11616.535338586362, 11679.532818687157, 11734.11994100446, 11939.820902686466, 19925.402237932885, 23880.40298992539, 24346.63480047801, 24357.51284974326, 24424.0, 8198.0, 8330.791730206793, 8485.0666426693, 8522.957385213034, 8536.957315213383, 4342.6308763754805, 4364.738115713068, 4381.461215329151, 4408.0071325042145, 4436.889077773081, 3649.543807024122, 3703.8333275002688, 3711.31340701971, 3813.7711737295294, 3819.732618716663, 670.8255853478131, 671.6272468779777, 672.4788289076005, 678.4267294136447, 687.4088284075691, 631.9273283572356, 684.8938414545753, 705.6083873450284, 712.8431745016088, 717.4977515739004, 9340.579673914553, 9621.749172607657, 9680.56437460316, 9764.218862491125, 9781.559829807677, 602.8523011862122, 641.9261784894703, 643.5752403413725, 691.7578847403469, 697.5431092634333, 4639.303606465947, 4732.5977291929885, 4740.620750339965, 4773.451053128865, 4888.682235654742, 110399.0, 139458.0, 139862.30068849592, 164145.17927410526, 164603.3539664588, 139491.0, 140091.0, 141409.0, 141424.0, 142083.0, 70506.2373440668, 96976.0, 101907.98092018985, 106791.0, 106964.46517767361, 8541.188587084218, 9016.954915225382, 9031.142041506046, 9047.281016606823, 9225.261979041794, 58560.12159817521, 61190.38809611847, 62046.0, 64418.677906610166, 66812.99561013178, 73685.0, 86150.0, 94650.0, 95164.52417737867, 97793.51103244438, 12376.876231237933, 12393.132480726263, 12394.690132746753, 12411.937940310241, 12551.121421500407, 13586.252756098509, 14028.088174269049, 14222.502212422516, 14364.497242596459, 14440.927795360956, 12518.311492867979, 12825.358732063547, 13090.803637945248, 13247.0, 13293.468261269827, 12782.36088195568, 12791.872081279069, 13025.934870325587, 13435.462581496631, 13450.529231476852, 12348.81476777831, 12685.556005539762, 12743.553975610808, 12860.485580577046, 12930.030247731645, 10729.892701073202, 10924.890751092387, 11396.601118961129, 11519.19365644397, 11769.764604708029, 9688.46713430768, 9788.412695238309, 10096.747581310527, 10327.277090603586, 10387.272890897866], "value": 7959.687505183685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 107.0, 114.0, 117.0, 118.0, 130.0, 169.0, 163.0, 115.0], "value": 125.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 175.0, 173.0, 124.0, 155.0, 158.0, 108.0, 154.0, 108.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 218.0, 223.0, 266.0, 269.0, 196.0, 229.0, 257.0, 199.0], "value": 225.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 76.0, 133.0, 59.0, 57.0, 57.0, 60.0, 140.0, 61.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 121.0, 72.0, 71.0, 73.0, 114.0, 65.0, 95.0, 147.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 84.0, 88.0, 85.0, 105.0, 130.0, 110.0, 84.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 96.0, 91.0, 117.0, 140.0, 106.0, 150.0, 115.0], "value": 110.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 78.0, 141.0, 138.0, 87.0, 87.0, 89.0, 89.0, 149.0], "value": 104.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 58.0, 57.0, 56.0, 57.0, 56.0, 56.0, 58.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 60.0, 77.0, 95.0, 120.0, 113.0, 88.0, 73.0, 70.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 87.0, 83.0, 89.0, 88.0, 83.0, 85.0, 87.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 167.0, 145.0, 136.0, 151.0, 126.0, 151.0, 197.0, 146.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 164.0, 163.0, 162.0, 165.0, 158.0, 165.0, 160.0, 231.0, 175.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 66.0, 66.0, 63.0, 63.0, 60.0, 76.0, 85.0], "value": 67.7, "unit": "score"}]}]} 11:17:12 INFO - Return code: 0 11:17:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:17:12 ERROR - # TBPL SUCCESS # 11:17:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:12 INFO - 2016-07-13 11:17:12.549 screenresolution[1678:10743] starting screenresolution argv=screenresolution get 11:17:12 INFO - 2016-07-13 11:17:12.553 screenresolution[1678:10743] Display 0: 1600x1200x32@60 11:17:12 INFO - 2016-07-13 11:17:12.559 screenresolution[1679:10746] starting screenresolution argv=screenresolution list 11:17:12 INFO - Available Modes on Display 0 11:17:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:12 INFO - Intel Iris: 11:17:12 INFO - Chipset Model: Intel Iris 11:17:12 INFO - Type: GPU 11:17:12 INFO - Bus: Built-In 11:17:12 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:12 INFO - Vendor: Intel (0x8086) 11:17:12 INFO - Device ID: 0x0a2e 11:17:12 INFO - Revision ID: 0x0009 11:17:12 INFO - Displays: 11:17:12 INFO - Display: 11:17:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:12 INFO - Display Serial Number: 1600x1200 60 11:17:12 INFO - Main Display: Yes 11:17:12 INFO - Mirror: Off 11:17:12 INFO - Online: Yes 11:17:12 INFO - Rotation: Supported 11:17:12 INFO - Return code: 0 11:17:12 INFO - Running post-action listener: _resource_record_post_action 11:17:12 INFO - ##### 11:17:12 INFO - ##### Finished run-tests step (success) 11:17:12 INFO - ##### 11:17:12 INFO - Running post-run listener: _resource_record_post_run 11:17:12 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31952384; Write bytes: 708358144; Read time: 199; Write time: 1947 11:17:12 INFO - TinderboxPrint: CPU usage
54.1% 11:17:12 INFO - TinderboxPrint: I/O read bytes / time
31,952,384 / 199 11:17:12 INFO - TinderboxPrint: I/O write bytes / time
708,358,144 / 1,947 11:17:12 INFO - TinderboxPrint: CPU idle
2,218.6 (45.9%) 11:17:12 INFO - TinderboxPrint: CPU system
972.7 (20.1%) 11:17:12 INFO - TinderboxPrint: CPU user
1,642.3 (34.0%) 11:17:12 INFO - TinderboxPrint: Swap in / out
434,647,040 / 0 11:17:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398924288; Write bytes: 392513536; Read time: 29659; Write time: 793 11:17:12 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29974016; Write bytes: 298170368; Read time: 181; Write time: 1109 11:17:13 INFO - Running post-run listener: _upload_blobber_files 11:17:13 INFO - Blob upload gear active. 11:17:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:17:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:14 INFO - (blobuploader) - INFO - Done attempting. 11:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:15 INFO - (blobuploader) - INFO - Done attempting. 11:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:17 INFO - (blobuploader) - INFO - Done attempting. 11:17:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:17 INFO - Return code: 0 11:17:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33cf011b64501e0eebf867fc93d301c2359de5d5b08404aff553a4ab73c856f6a27308036c017865a84118efec12f30dfebc03ec005bcbd19f51fbfc4937a69c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6c56d8959120a2f7aa045ce6e86bbf978dd03a4535f6d3469e74d1c4fd245e59057e63a09d61a885a72c68d69f4f86a4cd1054cf4a19ff95fe7185c1683084", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f23f3fe5c6949d03e103bb11418adcc30d28edceb244a9ba591d5c60705bd0556e5a76859832d955610dac511a2da0e9fc5700df4e4f9a47d814a2c898ac8de"} 11:17:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:17 INFO - Contents: 11:17:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33cf011b64501e0eebf867fc93d301c2359de5d5b08404aff553a4ab73c856f6a27308036c017865a84118efec12f30dfebc03ec005bcbd19f51fbfc4937a69c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6c56d8959120a2f7aa045ce6e86bbf978dd03a4535f6d3469e74d1c4fd245e59057e63a09d61a885a72c68d69f4f86a4cd1054cf4a19ff95fe7185c1683084", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f23f3fe5c6949d03e103bb11418adcc30d28edceb244a9ba591d5c60705bd0556e5a76859832d955610dac511a2da0e9fc5700df4e4f9a47d814a2c898ac8de"} 11:17:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:17 INFO - Copying logs to upload dir... 11:17:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.794474 ========= master_lag: 20.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-07-13 11:17:37.439718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-07-13 11:17:37.444114) ========= 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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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/33cf011b64501e0eebf867fc93d301c2359de5d5b08404aff553a4ab73c856f6a27308036c017865a84118efec12f30dfebc03ec005bcbd19f51fbfc4937a69c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6c56d8959120a2f7aa045ce6e86bbf978dd03a4535f6d3469e74d1c4fd245e59057e63a09d61a885a72c68d69f4f86a4cd1054cf4a19ff95fe7185c1683084", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f23f3fe5c6949d03e103bb11418adcc30d28edceb244a9ba591d5c60705bd0556e5a76859832d955610dac511a2da0e9fc5700df4e4f9a47d814a2c898ac8de"} build_url:https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/TB6YsEZKRv-dDhGzdVV_ag/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33cf011b64501e0eebf867fc93d301c2359de5d5b08404aff553a4ab73c856f6a27308036c017865a84118efec12f30dfebc03ec005bcbd19f51fbfc4937a69c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f6c56d8959120a2f7aa045ce6e86bbf978dd03a4535f6d3469e74d1c4fd245e59057e63a09d61a885a72c68d69f4f86a4cd1054cf4a19ff95fe7185c1683084", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f23f3fe5c6949d03e103bb11418adcc30d28edceb244a9ba591d5c60705bd0556e5a76859832d955610dac511a2da0e9fc5700df4e4f9a47d814a2c898ac8de"}' ========= master_lag: 5.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-07-13 11:17:42.660694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:17:42.661016) ========= 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.8LLfqtQ8cl/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.5c1Q7gXYo3/Listeners TMPDIR=/var/folders/t0/q6j3ybpx29q21vrxg9z4zx0800000w/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.005180 ========= master_lag: 0.99 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 11:17:43.655665) ========= ========= Started reboot skipped (results: 3, elapsed: 21 secs) (at 2016-07-13 11:17:43.655950) ========= ========= Finished reboot skipped (results: 3, elapsed: 21 secs) (at 2016-07-13 11:18:05.106971) ========= ========= Total master_lag: 31.32 =========