builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0162 starttime: 1461961589.61 results: success (0) buildid: 20160429122633 builduid: cf06e26fada646bbba4ac137080ff492 revision: a52334a7f440ed8b620f93223f1c30397d081cfc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.611146) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.611555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.611826) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.629165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.629441) ========= 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.wXFoYLLdup/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.vA1NhJqEgi/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-04-29 13:26:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.20M=0.001s 2016-04-29 13:26:29 (8.20 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.776282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.776640) ========= 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.wXFoYLLdup/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.vA1NhJqEgi/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.020301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:29.824486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 13:26:29.824796) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a52334a7f440ed8b620f93223f1c30397d081cfc --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 a52334a7f440ed8b620f93223f1c30397d081cfc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wXFoYLLdup/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.vA1NhJqEgi/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-04-29 13:26:29,898 truncating revision to first 12 chars 2016-04-29 13:26:29,898 Setting DEBUG logging. 2016-04-29 13:26:29,898 attempt 1/10 2016-04-29 13:26:29,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a52334a7f440?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 13:26:31,609 unpacking tar archive at: fx-team-a52334a7f440/testing/mozharness/ program finished with exit code 0 elapsedTime=1.959884 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-29 13:26:31.808642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:31.809006) ========= script_repo_revision: a52334a7f440ed8b620f93223f1c30397d081cfc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:31.809411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:31.809694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:26:31.826604) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-29 13:26:31.826962) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.wXFoYLLdup/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.vA1NhJqEgi/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:26:31 INFO - MultiFileLogger online at 20160429 13:26:31 in /builds/slave/test 13:26:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:26:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:32 INFO - {'append_to_log': False, 13:26:32 INFO - 'base_work_dir': '/builds/slave/test', 13:26:32 INFO - 'blob_upload_branch': 'Fx-Team', 13:26:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:32 INFO - 'branch': 'Fx-Team', 13:26:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:32 INFO - 'config_files': ('talos/mac_config.py',), 13:26:32 INFO - 'default_actions': ('clobber', 13:26:32 INFO - 'read-buildbot-config', 13:26:32 INFO - 'download-and-extract', 13:26:32 INFO - 'populate-webroot', 13:26:32 INFO - 'create-virtualenv', 13:26:32 INFO - 'install', 13:26:32 INFO - 'run-tests'), 13:26:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:32 INFO - 'download_minidump_stackwalk': True, 13:26:32 INFO - 'download_symbols': 'ondemand', 13:26:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:32 INFO - 'installer_path': 'installer.exe', 13:26:32 INFO - 'log_level': 'info', 13:26:32 INFO - 'log_name': 'talos', 13:26:32 INFO - 'log_to_console': True, 13:26:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:26:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:26:32 INFO - 'opt_config_files': (), 13:26:32 INFO - 'pip_index': False, 13:26:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:32 INFO - 'cmd': ('bash', 13:26:32 INFO - '-c', 13:26:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:32 INFO - 'enabled': True, 13:26:32 INFO - 'halt_on_failure': False, 13:26:32 INFO - 'name': 'check_screen_resolution'},), 13:26:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:32 INFO - 'cmd': ('bash', 13:26:32 INFO - '-c', 13:26:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:32 INFO - 'enabled': True, 13:26:32 INFO - 'halt_on_failure': False, 13:26:32 INFO - 'name': 'check_screen_resolution'},), 13:26:32 INFO - 'run_cmd_checks_enabled': True, 13:26:32 INFO - 'sps_profile': False, 13:26:32 INFO - 'sps_profile_interval': 0, 13:26:32 INFO - 'suite': 'dromaeojs', 13:26:32 INFO - 'system_bits': '32', 13:26:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:32 INFO - 'title': 't-yosemite-r7-0162', 13:26:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:32 INFO - 'use_talos_json': True, 13:26:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:32 INFO - 'work_dir': 'build'} 13:26:32 INFO - ##### 13:26:32 INFO - ##### Running clobber step. 13:26:32 INFO - ##### 13:26:32 INFO - Running pre-action listener: _resource_record_pre_action 13:26:32 INFO - Running main action method: clobber 13:26:32 INFO - rmtree: /builds/slave/test/build 13:26:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:34 INFO - Running post-action listener: _resource_record_post_action 13:26:34 INFO - ##### 13:26:34 INFO - ##### Running read-buildbot-config step. 13:26:34 INFO - ##### 13:26:34 INFO - Running pre-action listener: _resource_record_pre_action 13:26:34 INFO - Running main action method: read_buildbot_config 13:26:34 INFO - Using buildbot properties: 13:26:34 INFO - { 13:26:34 INFO - "project": "", 13:26:34 INFO - "product": "firefox", 13:26:34 INFO - "script_repo_revision": "production", 13:26:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:26:34 INFO - "repository": "", 13:26:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:26:34 INFO - "buildid": "20160429122633", 13:26:34 INFO - "pgo_build": "False", 13:26:34 INFO - "basedir": "/builds/slave/test", 13:26:34 INFO - "buildnumber": 797, 13:26:34 INFO - "slavename": "t-yosemite-r7-0162", 13:26:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:26:34 INFO - "platform": "yosemite_r7", 13:26:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:26:34 INFO - "branch": "fx-team", 13:26:34 INFO - "repo_path": "integration/fx-team", 13:26:34 INFO - "revision": "a52334a7f440ed8b620f93223f1c30397d081cfc", 13:26:34 INFO - "stage_platform": "macosx64", 13:26:34 INFO - "builduid": "cf06e26fada646bbba4ac137080ff492", 13:26:34 INFO - "slavebuilddir": "test" 13:26:34 INFO - } 13:26:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 13:26:34 INFO - Running post-action listener: _resource_record_post_action 13:26:34 INFO - ##### 13:26:34 INFO - ##### Running download-and-extract step. 13:26:34 INFO - ##### 13:26:34 INFO - Running pre-action listener: _resource_record_pre_action 13:26:34 INFO - Running main action method: download_and_extract 13:26:34 INFO - mkdir: /builds/slave/test/build/tests 13:26:34 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')]} 13:26:34 INFO - https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 13:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 13:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 13:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 13:26:35 INFO - Downloaded 1199 bytes. 13:26:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 13:26:35 INFO - Using the following test package requirements: 13:26:35 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 13:26:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 13:26:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 13:26:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'jsshell-mac.zip'], 13:26:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 13:26:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 13:26:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 13:26:35 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 13:26:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 13:26:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:26:35 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 13:26:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:26:35 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')]} 13:26:35 INFO - https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:26:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:26:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:26:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:26:36 INFO - Downloaded 18124299 bytes. 13:26:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:26:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:26:40 INFO - Return code: 0 13:26:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:26:40 INFO - https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:26:41 INFO - Downloaded 18124299 bytes. 13:26:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:26:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:26:45 INFO - Return code: 0 13:26: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')]} 13:26:45 INFO - https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:26:46 INFO - Downloaded 10840145 bytes. 13:26:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:26:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:26:46 INFO - Return code: 0 13:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:26:46 INFO - https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:26:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:26:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:26:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 13:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 13:26:49 INFO - Downloaded 110276108 bytes. 13:26:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:26:49 INFO - mkdir: /builds/slave/test/properties 13:26:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:49 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:49 INFO - Contents: 13:26:49 INFO - build_url:https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:26:50 INFO - Running post-action listener: _resource_record_post_action 13:26:50 INFO - Running post-action listener: set_extra_try_arguments 13:26:50 INFO - ##### 13:26:50 INFO - ##### Running populate-webroot step. 13:26:50 INFO - ##### 13:26:50 INFO - Running pre-action listener: _resource_record_pre_action 13:26:50 INFO - Running main action method: populate_webroot 13:26:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:50 INFO - '--tppagecycles', 13:26:50 INFO - '7'], 13:26:50 INFO - 'tests': ['tsvgm']}}, 13:26:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['damp', 'tps']}, 13:26:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'tests': ['damp', 'tps']}, 13:26:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['dromaeo_dom']}, 13:26:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['a11yr', 13:26:50 INFO - 'ts_paint', 13:26:50 INFO - 'tpaint', 13:26:50 INFO - 'sessionrestore', 13:26:50 INFO - 'sessionrestore_no_auto_restore', 13:26:50 INFO - 'tabpaint']}, 13:26:50 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:50 INFO - 'ts_paint', 13:26:50 INFO - 'tpaint', 13:26:50 INFO - 'sessionrestore', 13:26:50 INFO - 'sessionrestore_no_auto_restore', 13:26:50 INFO - 'tabpaint']}, 13:26:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:50 INFO - 'ts_paint', 13:26:50 INFO - 'tpaint', 13:26:50 INFO - 'sessionrestore', 13:26:50 INFO - 'sessionrestore_no_auto_restore', 13:26:50 INFO - 'tabpaint']}, 13:26:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:50 INFO - 'ts_paint', 13:26:50 INFO - 'tpaint', 13:26:50 INFO - 'sessionrestore', 13:26:50 INFO - 'sessionrestore_no_auto_restore', 13:26:50 INFO - 'tabpaint']}, 13:26:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['a11yr', 13:26:50 INFO - 'ts_paint', 13:26:50 INFO - 'tpaint', 13:26:50 INFO - 'sessionrestore', 13:26:50 INFO - 'sessionrestore_no_auto_restore', 13:26:50 INFO - 'tabpaint']}, 13:26:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['a11yr', 13:26:50 INFO - 'ts_paint', 13:26:50 INFO - 'tpaint', 13:26:50 INFO - 'sessionrestore', 13:26:50 INFO - 'sessionrestore_no_auto_restore', 13:26:50 INFO - 'tabpaint']}, 13:26:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['tsvgx', 13:26:50 INFO - 'tsvgr_opacity', 13:26:50 INFO - 'tart', 13:26:50 INFO - 'tscrollx', 13:26:50 INFO - 'cart']}, 13:26:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:50 INFO - 'tsvgr_opacity', 13:26:50 INFO - 'tart', 13:26:50 INFO - 'tscrollx', 13:26:50 INFO - 'cart']}, 13:26:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'talos_options': ['--disable-e10s'], 13:26:50 INFO - 'tests': ['tp5o']}, 13:26:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'tests': ['tp5o']}, 13:26:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'talos_options': ['--disable-e10s', 13:26:50 INFO - '--xperf_path', 13:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:50 INFO - 'tests': ['tp5n']}, 13:26:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:50 INFO - 'talos_options': ['--xperf_path', 13:26:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:50 INFO - 'tests': ['tp5n']}}, 13:26:50 INFO - 'talos.zip': {'path': '', 13:26:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:50 INFO - Running post-action listener: _resource_record_post_action 13:26:50 INFO - ##### 13:26:50 INFO - ##### Running create-virtualenv step. 13:26:50 INFO - ##### 13:26:50 INFO - Running pre-action listener: _resource_record_pre_action 13:26:50 INFO - Running main action method: create_virtualenv 13:26:50 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:26:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:50 INFO - Using real prefix '/tools/python27' 13:26:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:54 INFO - Installing pip.................done. 13:26:54 INFO - Return code: 0 13:26:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:54 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')]} 13:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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')]} 13:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:54 INFO - 'HOME': '/Users/cltbld', 13:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:54 INFO - 'LOGNAME': 'cltbld', 13:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:54 INFO - 'MOZ_NO_REMOTE': '1', 13:26:54 INFO - 'NO_EM_RESTART': '1', 13:26:54 INFO - 'PAGER': '/bin/cat', 13:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:54 INFO - 'PWD': '/builds/slave/test', 13:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:54 INFO - 'SHELL': '/bin/bash', 13:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:26:54 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:54 INFO - 'USER': 'cltbld', 13:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:54 INFO - 'XPC_FLAGS': '0x0', 13:26:54 INFO - 'XPC_SERVICE_NAME': '0', 13:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:26:54 INFO - Cleaning up... 13:26:54 INFO - Return code: 0 13:26:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:26:54 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')]} 13:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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')]} 13:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:26:54 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>=0.7.1'] in /builds/slave/test/build 13:26:54 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>=0.7.1 13:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:54 INFO - 'HOME': '/Users/cltbld', 13:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:54 INFO - 'LOGNAME': 'cltbld', 13:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:54 INFO - 'MOZ_NO_REMOTE': '1', 13:26:54 INFO - 'NO_EM_RESTART': '1', 13:26:54 INFO - 'PAGER': '/bin/cat', 13:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:54 INFO - 'PWD': '/builds/slave/test', 13:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:54 INFO - 'SHELL': '/bin/bash', 13:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:26:54 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:54 INFO - 'USER': 'cltbld', 13:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:54 INFO - 'XPC_FLAGS': '0x0', 13:26:54 INFO - 'XPC_SERVICE_NAME': '0', 13:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:54 INFO - Downloading/unpacking psutil>=0.7.1 13:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:57 INFO - Installing collected packages: psutil 13:26:57 INFO - Running setup.py install for psutil 13:26:57 INFO - building 'psutil._psutil_osx' extension 13:26:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:26:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:26:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:26:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:26:58 INFO - building 'psutil._psutil_posix' extension 13:26:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:26:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:26:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:26:58 INFO - ^ 13:26:58 INFO - 1 warning generated. 13:26:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:58 INFO - Successfully installed psutil 13:26:58 INFO - Cleaning up... 13:26:58 INFO - Return code: 0 13:26:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:58 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:26:58 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.0.0'] in /builds/slave/test/build 13:26:58 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.0.0 13:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:58 INFO - 'HOME': '/Users/cltbld', 13:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:58 INFO - 'LOGNAME': 'cltbld', 13:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:58 INFO - 'MOZ_NO_REMOTE': '1', 13:26:58 INFO - 'NO_EM_RESTART': '1', 13:26:58 INFO - 'PAGER': '/bin/cat', 13:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:58 INFO - 'PWD': '/builds/slave/test', 13:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:58 INFO - 'SHELL': '/bin/bash', 13:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:26:58 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:58 INFO - 'USER': 'cltbld', 13:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:58 INFO - 'XPC_FLAGS': '0x0', 13:26:58 INFO - 'XPC_SERVICE_NAME': '0', 13:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:27:01 INFO - Installing collected packages: mozsystemmonitor 13:27:01 INFO - Running setup.py install for mozsystemmonitor 13:27:01 INFO - Successfully installed mozsystemmonitor 13:27:01 INFO - Cleaning up... 13:27:01 INFO - Return code: 0 13:27:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:01 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 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:01 INFO - 'HOME': '/Users/cltbld', 13:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:01 INFO - 'LOGNAME': 'cltbld', 13:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:01 INFO - 'MOZ_NO_REMOTE': '1', 13:27:01 INFO - 'NO_EM_RESTART': '1', 13:27:01 INFO - 'PAGER': '/bin/cat', 13:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:01 INFO - 'PWD': '/builds/slave/test', 13:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:01 INFO - 'SHELL': '/bin/bash', 13:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:01 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:01 INFO - 'USER': 'cltbld', 13:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:01 INFO - 'XPC_FLAGS': '0x0', 13:27:01 INFO - 'XPC_SERVICE_NAME': '0', 13:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:01 INFO - Downloading/unpacking blobuploader==1.2.4 13:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:04 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:05 INFO - Downloading docopt-0.6.1.tar.gz 13:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:05 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:05 INFO - Running setup.py install for blobuploader 13:27:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:05 INFO - Running setup.py install for requests 13:27:06 INFO - Running setup.py install for docopt 13:27:06 INFO - Successfully installed blobuploader requests docopt 13:27:06 INFO - Cleaning up... 13:27:06 INFO - Return code: 0 13:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:06 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 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:27:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:06 INFO - 'HOME': '/Users/cltbld', 13:27:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:06 INFO - 'LOGNAME': 'cltbld', 13:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:06 INFO - 'MOZ_NO_REMOTE': '1', 13:27:06 INFO - 'NO_EM_RESTART': '1', 13:27:06 INFO - 'PAGER': '/bin/cat', 13:27:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:06 INFO - 'PWD': '/builds/slave/test', 13:27:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:06 INFO - 'SHELL': '/bin/bash', 13:27:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:06 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:06 INFO - 'USER': 'cltbld', 13:27:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:06 INFO - 'XPC_FLAGS': '0x0', 13:27:06 INFO - 'XPC_SERVICE_NAME': '0', 13:27:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ZdOAmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-LxqtCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-SxIMMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-c_MBUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-nFttrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ShKbFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Foybki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ARolu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-WbY2p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-oMZM62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8mwRYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GNHmS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-R5XlR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:07 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-WIm2s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:08 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ceefss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:08 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-WTTCcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:08 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Bkcgsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:08 INFO - Running setup.py install for manifestparser 13:27:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:08 INFO - Running setup.py install for mozcrash 13:27:08 INFO - Running setup.py install for mozdebug 13:27:08 INFO - Running setup.py install for mozdevice 13:27:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:27:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:08 INFO - Running setup.py install for mozfile 13:27:09 INFO - Running setup.py install for mozhttpd 13:27:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Running setup.py install for mozinfo 13:27:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Running setup.py install for mozInstall 13:27:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Running setup.py install for mozleak 13:27:09 INFO - Running setup.py install for mozlog 13:27:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:09 INFO - Running setup.py install for moznetwork 13:27:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:10 INFO - Running setup.py install for mozprocess 13:27:10 INFO - Running setup.py install for mozprofile 13:27:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:10 INFO - Running setup.py install for mozrunner 13:27:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:10 INFO - Running setup.py install for mozscreenshot 13:27:10 INFO - Running setup.py install for moztest 13:27:10 INFO - Running setup.py install for mozversion 13:27:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:10 INFO - Cleaning up... 13:27:10 INFO - Return code: 0 13:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:10 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 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:10 INFO - 'HOME': '/Users/cltbld', 13:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:10 INFO - 'LOGNAME': 'cltbld', 13:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:10 INFO - 'MOZ_NO_REMOTE': '1', 13:27:10 INFO - 'NO_EM_RESTART': '1', 13:27:10 INFO - 'PAGER': '/bin/cat', 13:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:10 INFO - 'PWD': '/builds/slave/test', 13:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:10 INFO - 'SHELL': '/bin/bash', 13:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:10 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:10 INFO - 'USER': 'cltbld', 13:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:10 INFO - 'XPC_FLAGS': '0x0', 13:27:10 INFO - 'XPC_SERVICE_NAME': '0', 13:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ZEayhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8HHmfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-V7Cue8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-liHQq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-BLH_ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Db8zMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xtDtwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-6l72iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-FcfZip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-jOg_Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-s3FufA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-687qfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-h1gpGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-da0sKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8SU8Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Oz4U7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:12 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MEXhIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:15 INFO - Downloading blessings-1.6.tar.gz 13:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:15 INFO - Installing collected packages: blessings 13:27:15 INFO - Running setup.py install for blessings 13:27:15 INFO - Successfully installed blessings 13:27:15 INFO - Cleaning up... 13:27:15 INFO - Return code: 0 13:27:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:16 INFO - Reading from file tmpfile_stdout 13:27:16 INFO - Current package versions: 13:27:16 INFO - blessings == 1.6 13:27:16 INFO - blobuploader == 1.2.4 13:27:16 INFO - docopt == 0.6.1 13:27:16 INFO - manifestparser == 1.1 13:27:16 INFO - mozInstall == 1.12 13:27:16 INFO - mozcrash == 0.17 13:27:16 INFO - mozdebug == 0.1 13:27:16 INFO - mozdevice == 0.48 13:27:16 INFO - mozfile == 1.2 13:27:16 INFO - mozhttpd == 0.7 13:27:16 INFO - mozinfo == 0.9 13:27:16 INFO - mozleak == 0.1 13:27:16 INFO - mozlog == 3.1 13:27:16 INFO - moznetwork == 0.27 13:27:16 INFO - mozprocess == 0.22 13:27:16 INFO - mozprofile == 0.28 13:27:16 INFO - mozrunner == 6.11 13:27:16 INFO - mozscreenshot == 0.1 13:27:16 INFO - mozsystemmonitor == 0.0 13:27:16 INFO - moztest == 0.7 13:27:16 INFO - mozversion == 1.4 13:27:16 INFO - psutil == 3.1.1 13:27:16 INFO - requests == 1.2.3 13:27:16 INFO - wsgiref == 0.1.2 13:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:16 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 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:16 INFO - 'HOME': '/Users/cltbld', 13:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:16 INFO - 'LOGNAME': 'cltbld', 13:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:16 INFO - 'MOZ_NO_REMOTE': '1', 13:27:16 INFO - 'NO_EM_RESTART': '1', 13:27:16 INFO - 'PAGER': '/bin/cat', 13:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:16 INFO - 'PWD': '/builds/slave/test', 13:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:16 INFO - 'SHELL': '/bin/bash', 13:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:16 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:16 INFO - 'USER': 'cltbld', 13:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:16 INFO - 'XPC_FLAGS': '0x0', 13:27:16 INFO - 'XPC_SERVICE_NAME': '0', 13:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:27:16 INFO - Cleaning up... 13:27:16 INFO - Return code: 0 13:27:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:27:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:16 INFO - 'HOME': '/Users/cltbld', 13:27:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:16 INFO - 'LOGNAME': 'cltbld', 13:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:16 INFO - 'MOZ_NO_REMOTE': '1', 13:27:16 INFO - 'NO_EM_RESTART': '1', 13:27:16 INFO - 'PAGER': '/bin/cat', 13:27:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:16 INFO - 'PWD': '/builds/slave/test', 13:27:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:16 INFO - 'SHELL': '/bin/bash', 13:27:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:16 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:16 INFO - 'USER': 'cltbld', 13:27:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:16 INFO - 'XPC_FLAGS': '0x0', 13:27:16 INFO - 'XPC_SERVICE_NAME': '0', 13:27:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:16 INFO - Downloading/unpacking jsonschema 13:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:27:18 INFO - Downloading/unpacking functools32 (from jsonschema) 13:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:19 INFO - Downloading functools32-3.2.3-2.tar.gz 13:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:27:19 INFO - warning: no files found matching '*.txt' 13:27:19 INFO - no previously-included directories found matching 'build' 13:27:19 INFO - no previously-included directories found matching 'dist' 13:27:19 INFO - no previously-included directories found matching '.git*' 13:27:19 INFO - Installing collected packages: jsonschema, functools32 13:27:19 INFO - Running setup.py install for functools32 13:27:19 INFO - warning: no files found matching '*.txt' 13:27:19 INFO - no previously-included directories found matching 'build' 13:27:19 INFO - no previously-included directories found matching 'dist' 13:27:19 INFO - no previously-included directories found matching '.git*' 13:27:19 INFO - Successfully installed jsonschema functools32 13:27:19 INFO - Cleaning up... 13:27:19 INFO - Return code: 0 13:27:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27: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')]} 13:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:19 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10936fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10937f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9694aba70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, '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.wXFoYLLdup/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.vA1NhJqEgi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:27:19 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', 'flake8'] in /builds/slave/test/build 13:27:19 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 flake8 13:27:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:19 INFO - 'HOME': '/Users/cltbld', 13:27:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:19 INFO - 'LOGNAME': 'cltbld', 13:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:19 INFO - 'MOZ_NO_REMOTE': '1', 13:27:19 INFO - 'NO_EM_RESTART': '1', 13:27:19 INFO - 'PAGER': '/bin/cat', 13:27:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:19 INFO - 'PWD': '/builds/slave/test', 13:27:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:19 INFO - 'SHELL': '/bin/bash', 13:27:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:19 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:19 INFO - 'USER': 'cltbld', 13:27:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:19 INFO - 'XPC_FLAGS': '0x0', 13:27:19 INFO - 'XPC_SERVICE_NAME': '0', 13:27:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:19 INFO - Downloading/unpacking flake8 13:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:27:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:27:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:27:23 INFO - no previously-included directories found matching 'docs/_build' 13:27:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:27:23 INFO - Running setup.py install for pep8 13:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:27:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:27:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:27:23 INFO - no previously-included directories found matching 'docs/_build' 13:27:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:27:23 INFO - Cleaning up... 13:27:23 INFO - Return code: 0 13:27:23 INFO - Running post-action listener: _resource_record_post_action 13:27:23 INFO - Running post-action listener: _start_resource_monitoring 13:27:23 INFO - Starting resource monitoring. 13:27:23 INFO - ##### 13:27:23 INFO - ##### Running install step. 13:27:23 INFO - ##### 13:27:23 INFO - Running pre-action listener: _resource_record_pre_action 13:27:23 INFO - Running main action method: install 13:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:24 INFO - Reading from file tmpfile_stdout 13:27:24 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:24 INFO - Reading from file tmpfile_stdout 13:27:24 INFO - Output received: 13:27:24 INFO - Usage: mozinstall [options] installer 13:27:24 INFO - Options: 13:27:24 INFO - -h, --help show this help message and exit 13:27:24 INFO - -d DEST, --destination=DEST 13:27:24 INFO - Directory to install application into. [default: 13:27:24 INFO - "/builds/slave/test"] 13:27:24 INFO - --app=APP Application being installed. [default: firefox] 13:27:24 INFO - mkdir: /builds/slave/test/build/application 13:27:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:27:58 INFO - Reading from file tmpfile_stdout 13:27:58 INFO - Output received: 13:27:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:27:58 INFO - Running post-action listener: _resource_record_post_action 13:27:58 INFO - ##### 13:27:58 INFO - ##### Running run-tests step. 13:27:58 INFO - ##### 13:27:58 INFO - Running pre-action listener: _resource_record_pre_action 13:27:58 INFO - Running main action method: run_tests 13:27:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:27:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:27:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:27:58 INFO - 2016-04-29 13:27:58.537 screenresolution[2215:68325] starting screenresolution argv=screenresolution get 13:27:58 INFO - 2016-04-29 13:27:58.539 screenresolution[2215:68325] Display 0: 1600x1200x32@60 13:27:58 INFO - 2016-04-29 13:27:58.545 screenresolution[2216:68328] starting screenresolution argv=screenresolution list 13:27:58 INFO - Available Modes on Display 0 13:27:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:27:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:27:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:27:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:27:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:27:58 INFO - Intel Iris: 13:27:58 INFO - Chipset Model: Intel Iris 13:27:58 INFO - Type: GPU 13:27:58 INFO - Bus: Built-In 13:27:58 INFO - VRAM (Dynamic, Max): 1536 MB 13:27:58 INFO - Vendor: Intel (0x8086) 13:27:58 INFO - Device ID: 0x0a2e 13:27:58 INFO - Revision ID: 0x0009 13:27:58 INFO - Displays: 13:27:58 INFO - Display: 13:27:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:27:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:27:58 INFO - Display Serial Number: 1600x1200 60 13:27:58 INFO - Main Display: Yes 13:27:58 INFO - Mirror: Off 13:27:58 INFO - Online: Yes 13:27:58 INFO - Rotation: Supported 13:27:58 INFO - Return code: 0 13:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:58 INFO - Python 2.7.3 13:27:58 INFO - Return code: 0 13:27:58 INFO - grabbing minidump binary from tooltool 13:27: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')]} 13:27:58 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10920ee00>, '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 0x109037db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109209b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:27:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:27:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:58 INFO - Return code: 0 13:27:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:27:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:27:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:27:59 INFO - Return code: 0 13:27:59 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:27:59 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:27:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wXFoYLLdup/Render', 13:27:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:59 INFO - 'HOME': '/Users/cltbld', 13:27:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:59 INFO - 'LOGNAME': 'cltbld', 13:27:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:59 INFO - 'MOZ_NO_REMOTE': '1', 13:27:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:59 INFO - 'NO_EM_RESTART': '1', 13:27:59 INFO - 'PAGER': '/bin/cat', 13:27:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:59 INFO - 'PWD': '/builds/slave/test', 13:27:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:59 INFO - 'SHELL': '/bin/bash', 13:27:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vA1NhJqEgi/Listeners', 13:27:59 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 13:27:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:59 INFO - 'USER': 'cltbld', 13:27:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:59 INFO - 'XPC_FLAGS': '0x0', 13:27:59 INFO - 'XPC_SERVICE_NAME': '0', 13:27:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:28:00 INFO - mozversion application_buildid: 20160429122633 13:28:00 INFO - mozversion application_changeset: a52334a7f440ed8b620f93223f1c30397d081cfc 13:28:00 INFO - mozversion application_display_name: Nightly 13:28:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:00 INFO - mozversion application_name: Firefox 13:28:00 INFO - mozversion application_remotingname: firefox 13:28:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:28:00 INFO - mozversion application_vendor: Mozilla 13:28:00 INFO - mozversion application_version: 49.0a1 13:28:00 INFO - mozversion platform_buildid: 20160429122633 13:28:00 INFO - mozversion platform_changeset: a52334a7f440ed8b620f93223f1c30397d081cfc 13:28:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:28:00 INFO - mozversion platform_version: 49.0a1 13:28:00 INFO - using testdate: 1461961680 13:28:00 INFO - actual date: 1461961680 13:28:00 INFO - starting webserver on 'localhost:53492' 13:28:00 INFO - SUITE-START | Running 2 tests 13:28:00 INFO - TEST-START | dromaeo_css 13:28:00 INFO - operating with platform_type : mac_ 13:28:00 INFO - Initialising browser for dromaeo_css test... 13:28:00 INFO - TEST-INFO | started process 2234 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpiENIhU/profile http://localhost:53492/getInfo.html) 13:28:02 INFO - PROCESS | 2234 | __metrics Screen width/height:1600/1200 13:28:02 INFO - PROCESS | 2234 | colorDepth:24 13:28:02 INFO - PROCESS | 2234 | Browser inner width/height: 1024/689 13:28:02 INFO - PROCESS | 2234 | __metrics 13:28:02 INFO - PROCESS | 2234 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:28:02 ERROR - PROCESS | 2234 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:28:03 INFO - TEST-INFO | 2234: exit 0 13:28:03 INFO - Browser initialized. 13:28:03 INFO - Running cycle 1/1 for dromaeo_css test... 13:28:03 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpiENIhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:15 INFO - PROCESS | 2236 | RSS: Main: 239583232 13:28:15 INFO - PROCESS | 2236 | 13:29:06 INFO - PROCESS | 2236 | 1461961746794 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:31:17 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53492/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53492/tests/dromaeo/cssquery-ext.html) 13:31:19 INFO - PROCESS | 2236 | RSS: Main: 354578432 13:31:19 INFO - PROCESS | 2236 | 13:34:21 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53492/tests/dromaeo/cssquery-ext.html (next: http://localhost:53492/tests/dromaeo/cssquery-jquery.html) 13:34:22 INFO - PROCESS | 2236 | RSS: Main: 376135680 13:34:22 INFO - PROCESS | 2236 | 13:37:24 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53492/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53492/tests/dromaeo/cssquery-mootools.html) 13:37:25 INFO - PROCESS | 2236 | RSS: Main: 370421760 13:37:25 INFO - PROCESS | 2236 | 13:40:27 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53492/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53492/tests/dromaeo/cssquery-prototype.html) 13:40:28 INFO - PROCESS | 2236 | RSS: Main: 370597888 13:40:28 INFO - PROCESS | 2236 | 13:43:31 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53492/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53492/tests/dromaeo/cssquery-yui.html) 13:43:32 INFO - PROCESS | 2236 | RSS: Main: 342564864 13:43:32 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | Cycle 1(1): loaded http://localhost:53492/tests/dromaeo/cssquery-yui.html (next: http://localhost:53492/tests/dromaeo/cssquery-dojo.html) 13:46:35 INFO - PROCESS | 2236 | RSS: Main: 408375296 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | __start_tp_report 13:46:35 INFO - PROCESS | 2236 | _x_x_mozilla_page_load 13:46:35 INFO - PROCESS | 2236 | _x_x_mozilla_page_load_details 13:46:35 INFO - PROCESS | 2236 | |i|pagename|runs| 13:46:35 INFO - PROCESS | 2236 | |0;dojo.html;2720.741529554692;3346.7155291800195;3370.7471939604534;3387.847546860391;3428.3314753623054;5566.721663916798;5574.86062848429;5638.295213098363;5666.291713535808;5693.231413759147;5602.719864006804;5605.5515558755305;5658.179563963233;5661.971690141543;5669.177969194464;5147.665401748893;5156.716380599066;5162.303089082963;5187.247849061884;5228.764705588239;5241.030409374259;5247.501487358714;5255.474452554752;5261.605379596526;5263.76313065911;5112.309838171855;5171.120909445403;5181.222816577506;5196.324477817879;5236.816711415101;5192.844214673547;5237.869053273661;5238.13570760824;5238.188080847474;5283.524482796528;5047.3438453001245;5109.642325037249;5145.794168233266;5148.021875843578;5171.095058364771;5395.028894798935;5412.242286079952;5493.807716729935;5527.723613819293;5553.250311208016;6193.628382297032;6203.5037197024585;6203.720832562501;6212.378762123797;6217.751289948396;6159.538034647419;6256.1866957295715;6258.405451482102;6263.029230469285;6274.623522588614;5626.127950167731;5632.802851900205;5711.600187986843;5770.798022069207;5782.7686892523825;6277.05844123376;6323.20959880015;6323.241211054611;6334.904976425358;6340.080688300263;6081.604695694766;6103.206583144251;6103.35914728956;6105.114758360013;6114.755409783648;5870.6771127587535;5883.382244864313;5951.613145145551;5953.583249172603;5955.13650520672;6089.51283897296;6139.916955224815;6145.108959200891;6145.924463218918;6178.073289006685;6121.602095863755;6157.076438534255;6165.0444181152;6182.443580077815;6183.103449999815;4751.216049351888;4816.90711662686;4866.6106711463;4879.316895634614;4906.803727850846;4421.579949904753;4459.554044595579;4461.353103799996;4464.955350446519;4499.977500112544;5642.097264437671;5654.15187721845;5662.57530685192;5671.092625179951;5681.801136960269;6194.473469755121;6242.219722534684;6252.656103914237;6255.218097737783;6261;5578.63738856973;5644.491995720323;5677.290338707661;5679.659220446786;5686.516646085046;5301.893962120736;5351.812686555952;5355.169948657965;5363.356397232357;5368.141097424394;6276.184096067482;6293.118963345227;6300;6306.873862522724;6307.337729538424;4399.49405818335;6070.666113363807;6125.632272693224;6208.50331973432;6225.190725205694;6275.246970363585;6287.371262873676;6290.087937248982;6337.04944258365;6339.080833279241;5172.818951336685;6115.174451448997;6115.357887421935;6133.754649813957;6155.261368635793;4770.403699537558;6081.969590152021;6158.353372895782;6172.8765424690355;6244.906326405016;6054.182685337423;6071.150038994632;6081.483073938588;6081.939180608314;6117.510599152146;6033.577649564489;6045.78839740607;6051.092336149437;6058.5153187745755;6063.757449701962;5739.799107031234;5793.391693872251;5846.824595262149;5877.853053673693;5891.764329426775;6019.1573179754;6074.939250607614;6078.422549857756;6086.969565152323;6095;5892.823215303548;5904.468597826216;5929.555283353679;5933.732982015906;5972.522198224045 13:46:35 INFO - PROCESS | 2236 | |1;ext.html;497.45528646132493;506.36704119850185;515.8504033830189;521.530622439804;531.7288183026658;28422.715772842264;31299.217519562022;31305.530417043734;31331.37337253259;31418.842905785437;31503.527447088312;33205;39596.40605390922;40702;40778.98052548688;9484.336096473233;9687.418754874694;9688.66089686861;9694.272929530278;9694.369865958726;8427.325813934902;9441.905580944205;9618.663346782863;9635.421874687541;9650.951745241264;8644.265237454792;11169.553217871275;11375.829362559569;11400.486978085964;11402;11403.3728144952;11568.826467602992;11574.942125289319;11577.594784182513;11592.652220433443;8388.412811103226;11089.500972456259;11251.887481125248;11371.772564548663;11454.713632159262;38960.22079558421;39434.80282598597;39516.407253891215;39535.8023209885;39541;3224.742020638343;3363.9831800841084;3513.350030244387;3544.929101417957;3909.463999483898;27718.86140569284;28067.719322806715;28082.297942551395;28380.290492737848;28701.85192592294;2690.233283514209;2717.3342531079816;2733.740294672003;2758.2966343582457;2783.7772978161697;488227;490426;490624;492279;492694;48755.51244487581;56988.71505642445;58176.418235817946;58227.12659310114;58259.70870145622;61152.69423652942;61464.69267653633;61680.69159654173;61689;61706.69146654238;13597.456101756017;16480.83519164817;16564.58588535272;16724.6655066898;16739.414120505724;12872.098953073195;12939.935300323437;12983.35083245853;13062.085654004128;13315.134516256412;15585.922070389575;15605.141717205435;17079.31682732677;17712.202950867242;18038.458846234633;6146.955017647011;6922.757703480454;7133.536320139175;7153.6780844862105;7216.097987751531;941.9576119074521;967.99032009679;970.1913652968483;1018.1294992781213;1082.1667316166665;29179.708202918122;29428.705712943025;29721.811127554654;30347;30588;1100.4772732951944;1100.8018556659717;1149;1160.5531870229854;1184.5735535207318;14861;15245.009074410127;15278.006929549543;15339.463118790789;15417.074975501506;625694.2014058973;633798;635486;636225;637268;60885.69557152186;62265.44336391536;62344.68827655833;62436.687816560625;62917;1282.24347634894;1461.8318893327403;1487.4496436318632;1490.046370322994;1491.8284397294233;24626.138085166935;29250.829966801943;29552.261193470335;29672.55491167591;30072.646730896726;53732;54288.45711542834;54604.726976364866;54665.90668186694;54700;575446;578981;579354;579967.1001644965;580209;22566.5486690262;25294.620580690935;25770.484590307715;25866.482670346864;26294.4741105173;39103;39212.60787392204;42493.362599560416;43976.12047759091;44041.339379909965;34544.136396590286;36950;37111.814440928705;37525.81237093797;37819.81090094532;34677.653223467445;36324.27351453009;36645.45031824578;37335.253294933405;37523.624763753105;35772;36073.81963090168;36630.8168459156;36795.08012299714;36900.26199476049;31280.530792037684;31750.523742143425;31881.043568692978;32513.674863251064;32882.17794555155;24646.876765616056;24662;24752.876235619427;24774;24925.376865578506 13:46:35 INFO - PROCESS | 2236 | |2;jquery.html;349.7936217631597;361.5859840482647;401.0715194325137;407.079999201804;407.2384640721851;19920.70118948215;21528.138874445023;21569.352919412402;21627.567448651018;22647.54704905901;19808.504787380323;20803;20809.583808323823;21418.785812141872;22473.438164045867;5018.197088465846;5284.706726171501;5507.118860982244;5507.146392309199;5512.448755124496;3240.400525902704;4120.19656167046;4139.3583994480905;5437.755301011464;5448;4066.5323487798987;4136.7176175385575;5773.191753154561;6104.847378815521;6126.571140020201;5724.22722932405;6069.6054756441135;6069.817905462799;6087.634741915477;6104.450599446049;5814.418558144152;5830.183774271605;5831.18363429116;5834.795782147647;5836.095405212199;13844.930775346058;13869.37587808551;13875.861241387558;13896.444142234299;14669.77995330071;1970.290695349673;2075.616011037963;2123.0764617391483;2146.9463263418384;2212.9225477108384;10412.94793526035;10793.83809242862;12759.787820157071;14433.566992990121;15204.695906081926;1645.234965740936;1712.8201538838366;1726.6633006563725;1772.503698964292;1807.5752198233404;120326;120467;122074;123708;126171.36914315462;9489.715308540755;11444.54221831134;11772.823407648892;11837.526498939946;11911.761764764657;15374.923125384525;15500.5349839505;15504.767428488582;15533.301001454736;15581.454649087227;8831.558422078999;8891.066438024043;8917.28661707075;8929.508877011827;8995.055519170524;7140;8788.560571971377;8834.602442890086;8918.643254269886;8936.151065648754;4673.462551806586;4731.266653668618;4740.502247264057;4747;4772.7136371817805;1700.4558541266676;1760.8631194345433;1838.6046999895086;1899;1992.8405727541763;770.3452065744185;891.2468963725642;898.8831451911341;944.5749412764284;1021.3157184686278;17354.566135846704;20211.292604758764;20984.79015209859;21294.148234070773;21349.78650213509;808.4017826808238;935.9859602105973;944.9480278584606;966.994325901069;973.9513024348896;9788.55951482185;10800.567977280978;10823.080038196842;10899.83650245247;10907.890921090846;243716;244371;545379.5462045408;593395;600021;130587.34706326408;138229.3088534551;141892;142958.2852085733;145461.54538454692;891.8573028315438;935.5462600638684;1031.28841099641;1069.5294070608907;1090.1032203965044;13868.653283667989;17525.298988040337;19239.230430783173;19489.902550487157;19597;36372.63528376612;46614.30078548892;52019.2197117036;52928.94142117213;54324.45675543194;70364;75081;76164;77006.2299376999;78735;7944.960275198587;8038.356931445353;8273.793155171168;8354.5405002723;8680.78298042554;6929.618870962146;12122.575709850113;12318;12773.2336059833;13105.27920964356;7273.418126549969;10817;11240.775184496428;11297.322160670386;11533.480993355486;10847.783044339227;11042.17183711241;11072;11262.436878155895;11356.716082098013;11083.279586827153;11277.266977646426;11556.075513959031;11601.883981160081;11719.06247500215;8312.044114926619;8327.791805204919;8526.957365213135;8561.48631082137;8576.614052367784;10578.8413173804;11283.492242849255;11396.08831293478;11407.828882566933;11636.709082273012 13:46:35 INFO - PROCESS | 2236 | |3;mootools.html;1441.0201063276982;1612.065002298667;1618.417369746891;1875.4748670372292;1984.0972357577295;7814.531128132316;8615.095414981422;8873.467591944487;8878.911210887889;8891.64433422664;8462.576871156449;8682.218600325969;8685.34859885508;8689.174528419806;8701.608427620757;2439.658447817307;2474.6288056791536;2476.0838489758817;2477.541654793869;2486.589712697403;2402.315340128064;2460.876956152194;2463.5072985402903;2470.765277298654;2480.3009938192304;2431.781139697427;2457.8893949772214;2465.8520488770732;2472.4560596668794;2476.7275599684112;2430.3802530354733;2440.1215562397524;2454.398672325283;2463.4457247119435;2470.8270421070533;2403.194929698553;2437.9146729864547;2440.804735621146;2444.4866578018637;2447.5839107351794;8513.318934485227;8661.220490155916;8744.650213991432;8747.956260218722;8750.474971501666;5237.869053273661;5474.616776825624;5491.121420572689;5511.311086114236;5519.116941289414;3445.2937147884622;3627.8911632650797;3659.963400365989;3668.192997540537;3729.962700372989;1042.6298663974333;1062.6865074802874;1064.11678307005;1071.089573862211;1072.469127781753;11300.94349528247;11399.886001140048;11413.029892459152;11425;11437.142214333959;4543.931841022388;4555.316702494586;4652.813887444532;4676.205045142334;4682.719036857799;7987.440879138405;9109.77018102561;9222.985471598118;9233.261339092856;9248.491332976751;5281.656692315064;5303.602229832778;5312.389075256395;5313.0967735485065;5321.547668448148;3901.297766402018;4400.669949753717;4584.885377865513;4881.707097574157;4953.0930591722445;3856.5179352580926;3895.3962135868987;3926.5079269877833;3950.170464202492;3965.841366345314;1216.9878301217052;1223.5534030078957;1229.8524177098805;1234.456838990841;1235.184778046485;656.3534918105662;728.5337384074197;886.7118186589385;900.5407242306339;986.4475893499663;5051.393832740095;5411.269478620336;5581.162825576115;5880.794172203952;5883.352831188566;1013.1185868294631;1014.1937159957852;1045.5190612318418;1071.346478648024;1071.8981696738797;3373;4027.6979226558124;4033.776259743639;4091.468109145792;4106.958930410718;10439.895601044043;10891.945540272249;10958.506867190996;10971.39657318839;10999.34003959765;10785.83821242682;10841.457927103613;10878.510467029002;10893.673189804318;10943.960323769388;8163.346932245406;8324.417290789586;8338.166183381612;8343.332533397313;8345.66617335312;5708.714564271687;5864.765409383577;5875.559333050124;5968.31364393083;6117.571769976059;9436.433813971184;9771.12059914611;10057.24570657189;10064.748381290527;10130.240231982778;9936.850947235653;10030.749231269278;10113.988601139827;10151.340162889388;10154.644587439405;7423.925760742323;7483.70065197386;7514.549127052176;7632.923670763222;7638.274363935418;8197.590120494071;8213.301869340934;8304.252617264476;8305.211004954519;8306.70926517569;6159.353267906985;7380.18817930038;7579.204183560647;7644.426667999811;7659.310662040443;7272.454565907472;7398.297161769623;7450.739224127129;7512.436567257369;7528.774136775905;6978.79063628092;7011.26381729911;7111.395531379684;7113.217546070032;7116.715331386687;4853.126437241331;4875.146849301429;5004.599632029356;5074.923876141787;5245.160774276097;4981.4769449207315;5031.421386540448;5089.13484707608;5142.717150556755;5316.255724198538 13:46:35 INFO - PROCESS | 2236 | |4;prototype.html;304.9801762885412;315.82629553745437;323.2742493102984;324.31893024648235;325.9348130373924;4688.859334219975;5143.305653736745;5283.943211357725;5348.277982472365;5348.652337598053;5000.349744686381;5305.734713264341;5307.25698402223;5317.308749862513;5324.361076670795;4003.7397569158056;4095.6279646318517;4099.508059032905;4131.731437456563;4145.875623731293;3234.4016356973916;3885.3977633466857;4131.19079026262;4165.458490396244;4186.35111557709;3362.6132994705677;3532.664396882305;3721.4789929409903;3935.3309937310582;4025.5974402559805;4010.5788892166192;4042.402261986834;4079.938800917989;4080.224757296104;4085.632293093606;3528.8412021459094;3535.805530695811;3542.5040494330815;3546.6098729139776;3563.7149028077692;4597.42532183477;4791.897863491382;4870.878228044292;5112.156494178456;5136.5890728741615;3677.8344974476213;4144.7513149210845;4185.686073544496;4516.93851944796;4597.7011494252765;4818.180909245437;5512.862178445571;5514.476124768141;5534.529564986981;5544.08935308962;3529.6470352964757;3561.358955388055;3676.4485327201132;3849.615038496128;3855.826487808027;4587.747673877969;5710.343310519302;5757.712114394263;5822.0684690449325;5823.737931793079;3344.6153692325206;3882.2235552889533;3885.592012838668;3902.785346805953;3924.372100463912;3155.936881262408;3258.3483303339426;3637.5816781070516;3736.103335199587;3976.4234186042863;3745.4943582616543;4075.7962101894786;4516.254817955067;4562.908741825145;4562.954370456319;5344;5546.445355464502;5584.86037849057;5610.859728506738;5614.803481878196;1390.958271251864;1413.194479146897;1448.5654303708845;1458.431211827388;1463.3122432456728;738.9889151662729;864.3301441382853;898.766320756608;940.6284517615503;943.7687766497252;4773.920821070459;5246.213068039825;5461.1262198048125;5731.541476681939;5745.195672605839;5036.5718913892;5169;5207.713575753294;5300.496452836975;5348.010618035676;4830.9371938173545;4972.477889821589;5228.555572776357;5433.8369848904595;5701.2588363513305;2993.416283824677;3260.7717459778064;3307.503874418808;3313.353895990259;3314.4919061826813;6190.2571691397325;6409.198850143732;6566.737330506726;6568.35456321746;6589.868202636017;5272.544699728723;5649.0396632572565;6038.33578306386;6040.969795150996;6054.666993315322;4834.806607735652;5489.92946375453;5570.749316280858;5964.194833697482;6057.666828324396;4797.544233297831;5411.567074634098;5759.211991948233;5800.906085465899;5927.6662750880705;5725.770969161354;5738.397468265772;5739.397363276796;5763.366029736641;5763.4812866842185;4759.690620109682;5351.725516655328;5563.666180029211;5903.616264942937;6006.288207860739;3341.9138779897116;3470.5661792275964;3657.158853463665;3984.442178095011;3989.0426297688928;4582.793774280099;4690.35837456901;5887.028640274478;5900.468957793819;5924.755801281779;4655.557722016403;5586.720663966704;5670.121131224667;5736.340320863154;5737.827865164052;5150;5643.4886475518;5649.830505084854;5675.659460432387;5794.3626201117;4425.269830477935;5232.947670523398;5413.215083812904;5647.463490968352;5655;4854.980454104678;4963;5481.409676661793;5642.88714225705;5661.490465858093;5206.392342776746;5609.775608975595;5621.381648018796;5639.182318563868;5674.631148975303 13:46:35 INFO - PROCESS | 2236 | |5;yui.html;645.3449748505265;672.2537982839049;680.9625470599118;732.7567000202991;739.9388184815858;13712.520061797839;14309.499167529139;14788.77816832747;15383.230838458074;15403.152826594533;11027;14857.182854943001;15376.308066137022;15455.149966751824;16156.788240881922;933.4259430450259;940.1022023967129;942.6182396129578;942.8067246214544;946.7207173883721;736.1718067174429;903.1465265324272;918.2608000559546;940.1538615246264;940.4310392212716;984.2618036472645;989.2481713897417;990.8018396320729;991.2218908157098;991.33085167512;975.1272611013139;982.8378317577591;983.1397527163732;984.8768903887014;986.146982859821;723.3851226457522;724.5652608434949;724.9057622509093;726.7347418192322;729.8467321862415;14562.053466524749;14876.479323223744;14877.404903803943;14883.77674334875;14981;12257.325847078408;12387.442565084593;12406.689832754164;12518.436670349765;12574.308413037279;9027.368084234105;9196.356255062148;9301.90698093017;9355.719328420158;9473.478958657272;3431.3823511767873;3448.448248280288;3495.3358861816428;3518.577770667511;3572.214112895185;71702.28297717008;72318.63840680815;72328.6383568084;72404.27595724029;77028.61485692592;9246.925081076255;9328.906710932939;9398.765030874283;9465.90534094664;9584.856227156599;21423.357299281048;21492.677609835864;21503.89248053781;21529.892350538146;21539.56920861574;7095.89356159658;7113.53762005468;7236.457265704988;7279.381252593483;7400.555966642019;3909.2181563687377;3986.342253528135;4000.3599424092586;4004.2992476316526;4006.959930400717;3403.4724617684296;3514.683678468899;3514.9824250878582;3526.5062891195253;3527.6295988920792;573.6147204501083;627.8430392401899;640.145405883142;645.602954183174;657.5298661457081;495.7446914838861;547.6850810783815;586.5073338395769;595.1548800702925;606.8968275393194;7722.845543089107;8004.479708818908;8031.196880311922;8121.106678265386;8250.339972802161;553.6760994817996;587.9470847623735;595.9493443057389;610.0574612224125;624.8437890527368;3646.7629604076183;3863.459115723801;3898.7660740355104;3902.083010492532;3941.980290098531;88731;92163.07836921679;92509.5374523123;94815.57776633356;99959.50020249997;52108;72540;78593;82487.17512824915;86099.65200728734;64304.713905721626;65689.0293291202;65886.34113658898;66627.66686166635;74817;6527;7975.920240797518;8099.14958929304;8158;8257.516463685202;41791.79104104581;42235.73292801221;42434.787826060674;43410.69767906968;44292.4497642581;57727.55681107838;58199.4180058194;58689;61911.38088619236;63019.6849015752;8803.60383782744;10667.626633067805;10752.784944300915;10931.83602245983;11215.943920280346;11901.702457438634;11913.880861191277;11981.221220620631;12390.62828115158;12761.61715148547;9535.761605959906;11234.775304494027;11568.826467602825;12011.399430028638;12315.815262770886;11109.888901110886;11323.716907077389;11515.884841151481;11624.302541847515;12195.817062743889;11164.106871450102;11238.943805280922;11402.714932126763;11450.82823757661;12192.207506512048;9294.953525232331;9400.95299523498;9716;9738.172255358373;10506.737331566466;7770.922290777246;8723.302135829246;8744.91255087441;8818.11818818113;9364.81270374575 13:46:35 INFO - PROCESS | 2236 | __end_tp_report 13:46:35 INFO - PROCESS | 2236 | __start_cc_report 13:46:35 INFO - PROCESS | 2236 | _x_x_mozilla_cycle_collect,1167 13:46:35 INFO - PROCESS | 2236 | __end_cc_report 13:46:35 INFO - PROCESS | 2236 | __startTimestamp1461962795414__endTimestamp 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | ------- Summary: start ------- 13:46:35 INFO - PROCESS | 2236 | Number of tests: 6 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | [#0] dojo.html Cycles:165 Average:5671.77 Median:5877.85 stddev:651.48 (11.1%) stddev-sans-first:610.97 13:46:35 INFO - PROCESS | 2236 | Values: 2720.7 3346.7 3370.7 3387.8 3428.3 5566.7 5574.9 5638.3 5666.3 5693.2 5602.7 5605.6 5658.2 5662.0 5669.2 5147.7 5156.7 5162.3 5187.2 5228.8 5241.0 5247.5 5255.5 5261.6 5263.8 5112.3 5171.1 5181.2 5196.3 5236.8 5192.8 5237.9 5238.1 5238.2 5283.5 5047.3 5109.6 5145.8 5148.0 5171.1 5395.0 5412.2 5493.8 5527.7 5553.3 6193.6 6203.5 6203.7 6212.4 6217.8 6159.5 6256.2 6258.4 6263.0 6274.6 5626.1 5632.8 5711.6 5770.8 5782.8 6277.1 6323.2 6323.2 6334.9 6340.1 6081.6 6103.2 6103.4 6105.1 6114.8 5870.7 5883.4 5951.6 5953.6 5955.1 6089.5 6139.9 6145.1 6145.9 6178.1 6121.6 6157.1 6165.0 6182.4 6183.1 4751.2 4816.9 4866.6 4879.3 4906.8 4421.6 4459.6 4461.4 4465.0 4500.0 5642.1 5654.2 5662.6 5671.1 5681.8 6194.5 6242.2 6252.7 6255.2 6261.0 5578.6 5644.5 5677.3 5679.7 5686.5 5301.9 5351.8 5355.2 5363.4 5368.1 6276.2 6293.1 6300.0 6306.9 6307.3 4399.5 6070.7 6125.6 6208.5 6225.2 6275.2 6287.4 6290.1 6337.0 6339.1 5172.8 6115.2 6115.4 6133.8 6155.3 4770.4 6082.0 6158.4 6172.9 6244.9 6054.2 6071.2 6081.5 6081.9 6117.5 6033.6 6045.8 6051.1 6058.5 6063.8 5739.8 5793.4 5846.8 5877.9 5891.8 6019.2 6074.9 6078.4 6087.0 6095.0 5892.8 5904.5 5929.6 5933.7 5972.5 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | [#1] ext.html Cycles:180 Average:69316.03 Median:19095.50 stddev:152661.35 (799.5%) stddev-sans-first:153002.17 13:46:35 INFO - PROCESS | 2236 | Values: 497.5 506.4 515.9 521.5 531.7 28422.7 31299.2 31305.5 31331.4 31418.8 31503.5 33205.0 39596.4 40702.0 40779.0 9484.3 9687.4 9688.7 9694.3 9694.4 8427.3 9441.9 9618.7 9635.4 9651.0 8644.3 11169.6 11375.8 11400.5 11402.0 11403.4 11568.8 11574.9 11577.6 11592.7 8388.4 11089.5 11251.9 11371.8 11454.7 38960.2 39434.8 39516.4 39535.8 39541.0 3224.7 3364.0 3513.4 3544.9 3909.5 27718.9 28067.7 28082.3 28380.3 28701.9 2690.2 2717.3 2733.7 2758.3 2783.8 488227.0 490426.0 490624.0 492279.0 492694.0 48755.5 56988.7 58176.4 58227.1 58259.7 61152.7 61464.7 61680.7 61689.0 61706.7 13597.5 16480.8 16564.6 16724.7 16739.4 12872.1 12939.9 12983.4 13062.1 13315.1 15585.9 15605.1 17079.3 17712.2 18038.5 6147.0 6922.8 7133.5 7153.7 7216.1 942.0 968.0 970.2 1018.1 1082.2 29179.7 29428.7 29721.8 30347.0 30588.0 1100.5 1100.8 1149.0 1160.6 1184.6 14861.0 15245.0 15278.0 15339.5 15417.1 625694.2 633798.0 635486.0 636225.0 637268.0 60885.7 62265.4 62344.7 62436.7 62917.0 1282.2 1461.8 1487.4 1490.0 1491.8 24626.1 29250.8 29552.3 29672.6 30072.6 53732.0 54288.5 54604.7 54665.9 54700.0 575446.0 578981.0 579354.0 579967.1 580209.0 22566.5 25294.6 25770.5 25866.5 26294.5 39103.0 39212.6 42493.4 43976.1 44041.3 34544.1 36950.0 37111.8 37525.8 37819.8 34677.7 36324.3 36645.5 37335.3 37523.6 35772.0 36073.8 36630.8 36795.1 36900.3 31280.5 31750.5 31881.0 32513.7 32882.2 24646.9 24662.0 24752.9 24774.0 24925.4 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | [#2] jquery.html Cycles:180 Average:30749.50 Median:21598.46 stddev:81533.90 (377.5%) stddev-sans-first:81730.67 13:46:35 INFO - PROCESS | 2236 | Values: 349.8 361.6 401.1 407.1 407.2 19920.7 21528.1 21569.4 21627.6 22647.5 19808.5 20803.0 20809.6 21418.8 22473.4 5018.2 5284.7 5507.1 5507.1 5512.4 3240.4 4120.2 4139.4 5437.8 5448.0 4066.5 4136.7 5773.2 6104.8 6126.6 5724.2 6069.6 6069.8 6087.6 6104.5 5814.4 5830.2 5831.2 5834.8 5836.1 13844.9 13869.4 13875.9 13896.4 14669.8 1970.3 2075.6 2123.1 2146.9 2212.9 10412.9 10793.8 12759.8 14433.6 15204.7 1645.2 1712.8 1726.7 1772.5 1807.6 120326.0 120467.0 122074.0 123708.0 126171.4 9489.7 11444.5 11772.8 11837.5 11911.8 15374.9 15500.5 15504.8 15533.3 15581.5 8831.6 8891.1 8917.3 8929.5 8995.1 7140.0 8788.6 8834.6 8918.6 8936.2 4673.5 4731.3 4740.5 4747.0 4772.7 1700.5 1760.9 1838.6 1899.0 1992.8 770.3 891.2 898.9 944.6 1021.3 17354.6 20211.3 20984.8 21294.1 21349.8 808.4 936.0 944.9 967.0 974.0 9788.6 10800.6 10823.1 10899.8 10907.9 243716.0 244371.0 545379.5 593395.0 600021.0 130587.3 138229.3 141892.0 142958.3 145461.5 891.9 935.5 1031.3 1069.5 1090.1 13868.7 17525.3 19239.2 19489.9 19597.0 36372.6 46614.3 52019.2 52928.9 54324.5 70364.0 75081.0 76164.0 77006.2 78735.0 7945.0 8038.4 8273.8 8354.5 8680.8 6929.6 12122.6 12318.0 12773.2 13105.3 7273.4 10817.0 11240.8 11297.3 11533.5 10847.8 11042.2 11072.0 11262.4 11356.7 11083.3 11277.3 11556.1 11601.9 11719.1 8312.0 8327.8 8527.0 8561.5 8576.6 10578.8 11283.5 11396.1 11407.8 11636.7 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | [#3] mootools.html Cycles:180 Average:5694.65 Median:4864.14 stddev:3145.94 (64.7%) stddev-sans-first:3138.52 13:46:35 INFO - PROCESS | 2236 | Values: 1441.0 1612.1 1618.4 1875.5 1984.1 7814.5 8615.1 8873.5 8878.9 8891.6 8462.6 8682.2 8685.3 8689.2 8701.6 2439.7 2474.6 2476.1 2477.5 2486.6 2402.3 2460.9 2463.5 2470.8 2480.3 2431.8 2457.9 2465.9 2472.5 2476.7 2430.4 2440.1 2454.4 2463.4 2470.8 2403.2 2437.9 2440.8 2444.5 2447.6 8513.3 8661.2 8744.7 8748.0 8750.5 5237.9 5474.6 5491.1 5511.3 5519.1 3445.3 3627.9 3660.0 3668.2 3730.0 1042.6 1062.7 1064.1 1071.1 1072.5 11300.9 11399.9 11413.0 11425.0 11437.1 4543.9 4555.3 4652.8 4676.2 4682.7 7987.4 9109.8 9223.0 9233.3 9248.5 5281.7 5303.6 5312.4 5313.1 5321.5 3901.3 4400.7 4584.9 4881.7 4953.1 3856.5 3895.4 3926.5 3950.2 3965.8 1217.0 1223.6 1229.9 1234.5 1235.2 656.4 728.5 886.7 900.5 986.4 5051.4 5411.3 5581.2 5880.8 5883.4 1013.1 1014.2 1045.5 1071.3 1071.9 3373.0 4027.7 4033.8 4091.5 4107.0 10439.9 10891.9 10958.5 10971.4 10999.3 10785.8 10841.5 10878.5 10893.7 10944.0 8163.3 8324.4 8338.2 8343.3 8345.7 5708.7 5864.8 5875.6 5968.3 6117.6 9436.4 9771.1 10057.2 10064.7 10130.2 9936.9 10030.7 10114.0 10151.3 10154.6 7423.9 7483.7 7514.5 7632.9 7638.3 8197.6 8213.3 8304.3 8305.2 8306.7 6159.4 7380.2 7579.2 7644.4 7659.3 7272.5 7398.3 7450.7 7512.4 7528.8 6978.8 7011.3 7111.4 7113.2 7116.7 4853.1 4875.1 5004.6 5074.9 5245.2 4981.5 5031.4 5089.1 5142.7 5316.3 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | [#4] prototype.html Cycles:180 Average:4536.88 Median:5124.37 stddev:1410.77 (27.5%) stddev-sans-first:1378.51 13:46:35 INFO - PROCESS | 2236 | Values: 305.0 315.8 323.3 324.3 325.9 4688.9 5143.3 5283.9 5348.3 5348.7 5000.3 5305.7 5307.3 5317.3 5324.4 4003.7 4095.6 4099.5 4131.7 4145.9 3234.4 3885.4 4131.2 4165.5 4186.4 3362.6 3532.7 3721.5 3935.3 4025.6 4010.6 4042.4 4079.9 4080.2 4085.6 3528.8 3535.8 3542.5 3546.6 3563.7 4597.4 4791.9 4870.9 5112.2 5136.6 3677.8 4144.8 4185.7 4516.9 4597.7 4818.2 5512.9 5514.5 5534.5 5544.1 3529.6 3561.4 3676.4 3849.6 3855.8 4587.7 5710.3 5757.7 5822.1 5823.7 3344.6 3882.2 3885.6 3902.8 3924.4 3155.9 3258.3 3637.6 3736.1 3976.4 3745.5 4075.8 4516.3 4562.9 4563.0 5344.0 5546.4 5584.9 5610.9 5614.8 1391.0 1413.2 1448.6 1458.4 1463.3 739.0 864.3 898.8 940.6 943.8 4773.9 5246.2 5461.1 5731.5 5745.2 5036.6 5169.0 5207.7 5300.5 5348.0 4830.9 4972.5 5228.6 5433.8 5701.3 2993.4 3260.8 3307.5 3313.4 3314.5 6190.3 6409.2 6566.7 6568.4 6589.9 5272.5 5649.0 6038.3 6041.0 6054.7 4834.8 5489.9 5570.7 5964.2 6057.7 4797.5 5411.6 5759.2 5800.9 5927.7 5725.8 5738.4 5739.4 5763.4 5763.5 4759.7 5351.7 5563.7 5903.6 6006.3 3341.9 3470.6 3657.2 3984.4 3989.0 4582.8 4690.4 5887.0 5900.5 5924.8 4655.6 5586.7 5670.1 5736.3 5737.8 5150.0 5643.5 5649.8 5675.7 5794.4 4425.3 5232.9 5413.2 5647.5 5655.0 4855.0 4963.0 5481.4 5642.9 5661.5 5206.4 5609.8 5621.4 5639.2 5674.6 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - PROCESS | 2236 | [#5] yui.html Cycles:180 Average:17456.75 Median:31823.76 stddev:24416.86 (76.7%) stddev-sans-first:24452.72 13:46:35 INFO - PROCESS | 2236 | Values: 645.3 672.3 681.0 732.8 739.9 13712.5 14309.5 14788.8 15383.2 15403.2 11027.0 14857.2 15376.3 15455.1 16156.8 933.4 940.1 942.6 942.8 946.7 736.2 903.1 918.3 940.2 940.4 984.3 989.2 990.8 991.2 991.3 975.1 982.8 983.1 984.9 986.1 723.4 724.6 724.9 726.7 729.8 14562.1 14876.5 14877.4 14883.8 14981.0 12257.3 12387.4 12406.7 12518.4 12574.3 9027.4 9196.4 9301.9 9355.7 9473.5 3431.4 3448.4 3495.3 3518.6 3572.2 71702.3 72318.6 72328.6 72404.3 77028.6 9246.9 9328.9 9398.8 9465.9 9584.9 21423.4 21492.7 21503.9 21529.9 21539.6 7095.9 7113.5 7236.5 7279.4 7400.6 3909.2 3986.3 4000.4 4004.3 4007.0 3403.5 3514.7 3515.0 3526.5 3527.6 573.6 627.8 640.1 645.6 657.5 495.7 547.7 586.5 595.2 606.9 7722.8 8004.5 8031.2 8121.1 8250.3 553.7 587.9 595.9 610.1 624.8 3646.8 3863.5 3898.8 3902.1 3942.0 88731.0 92163.1 92509.5 94815.6 99959.5 52108.0 72540.0 78593.0 82487.2 86099.7 64304.7 65689.0 65886.3 66627.7 74817.0 6527.0 7975.9 8099.1 8158.0 8257.5 41791.8 42235.7 42434.8 43410.7 44292.4 57727.6 58199.4 58689.0 61911.4 63019.7 8803.6 10667.6 10752.8 10931.8 11215.9 11901.7 11913.9 11981.2 12390.6 12761.6 9535.8 11234.8 11568.8 12011.4 12315.8 11109.9 11323.7 11515.9 11624.3 12195.8 11164.1 11238.9 11402.7 11450.8 12192.2 9295.0 9401.0 9716.0 9738.2 10506.7 7770.9 8723.3 8744.9 8818.1 9364.8 13:46:35 INFO - PROCESS | 2236 | -------- Summary: end -------- 13:46:35 INFO - PROCESS | 2236 | 13:46:35 INFO - TEST-INFO | 2236: exit 0 13:46:35 INFO - TEST-OK | dromaeo_css | took 1115815ms 13:46:35 INFO - TEST-START | kraken 13:46:35 INFO - operating with platform_type : mac_ 13:46:35 INFO - Initialising browser for kraken test... 13:46:36 INFO - TEST-INFO | started process 2240 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp1cGxSZ/profile http://localhost:53492/getInfo.html) 13:46:38 INFO - PROCESS | 2240 | __metrics Screen width/height:1600/1200 13:46:38 INFO - PROCESS | 2240 | colorDepth:24 13:46:38 INFO - PROCESS | 2240 | Browser inner width/height: 1024/689 13:46:38 INFO - PROCESS | 2240 | __metrics 13:46:38 INFO - PROCESS | 2240 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:46:38 ERROR - PROCESS | 2240 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:46:38 INFO - TEST-INFO | 2240: exit 0 13:46:38 INFO - Browser initialized. 13:46:38 INFO - Running cycle 1/1 for kraken test... 13:46:38 INFO - TEST-INFO | started process 2242 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp1cGxSZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:50 INFO - PROCESS | 2242 | RSS: Main: 239607808 13:46:50 INFO - PROCESS | 2242 | 13:46:53 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53492/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:54 INFO - PROCESS | 2242 | RSS: Main: 287576064 13:46:54 INFO - PROCESS | 2242 | 13:46:57 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53492/tests/kraken/driver.html?testName=audio-dft) 13:46:57 INFO - PROCESS | 2242 | RSS: Main: 295690240 13:46:57 INFO - PROCESS | 2242 | 13:47:01 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53492/tests/kraken/driver.html?testName=audio-fft) 13:47:01 INFO - PROCESS | 2242 | RSS: Main: 382197760 13:47:01 INFO - PROCESS | 2242 | 13:47:03 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53492/tests/kraken/driver.html?testName=audio-oscillator) 13:47:04 INFO - PROCESS | 2242 | RSS: Main: 279781376 13:47:04 INFO - PROCESS | 2242 | 13:47:06 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53492/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:07 INFO - PROCESS | 2242 | RSS: Main: 283885568 13:47:07 INFO - PROCESS | 2242 | 13:47:09 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53492/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:10 INFO - PROCESS | 2242 | RSS: Main: 323457024 13:47:10 INFO - PROCESS | 2242 | 13:47:13 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53492/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:13 INFO - PROCESS | 2242 | RSS: Main: 322699264 13:47:13 INFO - PROCESS | 2242 | 13:47:16 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53492/tests/kraken/driver.html?testName=json-parse-financial) 13:47:17 INFO - PROCESS | 2242 | RSS: Main: 323178496 13:47:17 INFO - PROCESS | 2242 | 13:47:18 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53492/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:19 INFO - PROCESS | 2242 | RSS: Main: 314949632 13:47:19 INFO - PROCESS | 2242 | 13:47:21 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:22 INFO - PROCESS | 2242 | RSS: Main: 322875392 13:47:22 INFO - PROCESS | 2242 | 13:47:24 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:25 INFO - PROCESS | 2242 | RSS: Main: 323502080 13:47:25 INFO - PROCESS | 2242 | 13:47:27 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:28 INFO - PROCESS | 2242 | RSS: Main: 328470528 13:47:28 INFO - PROCESS | 2242 | 13:47:31 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:31 INFO - PROCESS | 2242 | RSS: Main: 325894144 13:47:31 INFO - PROCESS | 2242 | 13:47:33 INFO - PROCESS | 2242 | Cycle 1(1): loaded http://localhost:53492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53492/tests/kraken/driver.html?testName=ai-astar) 13:47:34 INFO - PROCESS | 2242 | RSS: Main: 390483968 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | __start_tp_report 13:47:34 INFO - PROCESS | 2242 | _x_x_mozilla_page_load 13:47:34 INFO - PROCESS | 2242 | _x_x_mozilla_page_load_details 13:47:34 INFO - PROCESS | 2242 | |i|pagename|runs| 13:47:34 INFO - PROCESS | 2242 | |0;ai-astar;112;111;106;112;115;159;167;113;106;112 13:47:34 INFO - PROCESS | 2242 | |1;audio-beat-detection;160;123;146;174;120;141;126;125;209;148 13:47:34 INFO - PROCESS | 2242 | |2;audio-dft;187;186;184;186;187;185;184;185;185;185 13:47:34 INFO - PROCESS | 2242 | |3;audio-fft;77;76;89;92;57;58;57;83;88;55 13:47:34 INFO - PROCESS | 2242 | |4;audio-oscillator;94;98;134;79;77;80;126;79;76;130 13:47:34 INFO - PROCESS | 2242 | |5;imaging-gaussian-blur;87;84;87;84;88;83;87;86;88;84 13:47:34 INFO - PROCESS | 2242 | |6;imaging-darkroom;93;97;93;92;92;93;94;93;93;93 13:47:34 INFO - PROCESS | 2242 | |7;imaging-desaturate;90;87;87;89;88;87;100;86;93;144 13:47:34 INFO - PROCESS | 2242 | |8;json-parse-financial;60;62;59;59;61;60;59;75;61;59 13:47:34 INFO - PROCESS | 2242 | |9;json-stringify-tinderbox;63;70;80;79;69;70;67;69;71;71 13:47:34 INFO - PROCESS | 2242 | |10;stanford-crypto-aes;82;85;99;107;109;105;82;82;82;82 13:47:34 INFO - PROCESS | 2242 | |11;stanford-crypto-ccm;131;138;137;136;135;149;157;141;175;139 13:47:34 INFO - PROCESS | 2242 | |12;stanford-crypto-pbkdf2;170;170;174;164;164;168;168;169;170;165 13:47:34 INFO - PROCESS | 2242 | |13;stanford-crypto-sha256-iterative;69;67;68;68;76;96;102;99;89;70 13:47:34 INFO - PROCESS | 2242 | __end_tp_report 13:47:34 INFO - PROCESS | 2242 | __start_cc_report 13:47:34 INFO - PROCESS | 2242 | _x_x_mozilla_cycle_collect,1972 13:47:34 INFO - PROCESS | 2242 | __end_cc_report 13:47:34 INFO - PROCESS | 2242 | __startTimestamp1461962854033__endTimestamp 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | ------- Summary: start ------- 13:47:34 INFO - PROCESS | 2242 | Number of tests: 14 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#0] ai-astar Cycles:10 Average:121.30 Median:112.50 stddev:22.24 (19.8%) stddev-sans-first:23.33 13:47:34 INFO - PROCESS | 2242 | Values: 112.0 111.0 106.0 112.0 115.0 159.0 167.0 113.0 106.0 112.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:147.00 stddev:27.91 (19.0%) stddev-sans-first:29.21 13:47:34 INFO - PROCESS | 2242 | Values: 160.0 123.0 146.0 174.0 120.0 141.0 126.0 125.0 209.0 148.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.50 stddev:1.07 (0.6%) stddev-sans-first:0.97 13:47:34 INFO - PROCESS | 2242 | Values: 187.0 186.0 184.0 186.0 187.0 185.0 184.0 185.0 185.0 185.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#3] audio-fft Cycles:10 Average:73.20 Median:80.00 stddev:15.01 (18.8%) stddev-sans-first:15.86 13:47:34 INFO - PROCESS | 2242 | Values: 77.0 76.0 89.0 92.0 57.0 58.0 57.0 83.0 88.0 55.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:79.00 stddev:23.77 (30.1%) stddev-sans-first:25.18 13:47:34 INFO - PROCESS | 2242 | Values: 94.0 98.0 134.0 79.0 77.0 80.0 126.0 79.0 76.0 130.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.87 (2.2%) stddev-sans-first:1.94 13:47:34 INFO - PROCESS | 2242 | Values: 87.0 84.0 87.0 84.0 88.0 83.0 87.0 86.0 88.0 84.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 13:47:34 INFO - PROCESS | 2242 | Values: 93.0 97.0 93.0 92.0 92.0 93.0 94.0 93.0 93.0 93.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:87.50 stddev:17.68 (20.2%) stddev-sans-first:18.65 13:47:34 INFO - PROCESS | 2242 | Values: 90.0 87.0 87.0 89.0 88.0 87.0 100.0 86.0 93.0 144.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.50 stddev:4.86 (8.0%) stddev-sans-first:5.12 13:47:34 INFO - PROCESS | 2242 | Values: 60.0 62.0 59.0 59.0 61.0 60.0 59.0 75.0 61.0 59.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:70.50 stddev:5.11 (7.2%) stddev-sans-first:4.55 13:47:34 INFO - PROCESS | 2242 | Values: 63.0 70.0 80.0 79.0 69.0 70.0 67.0 69.0 71.0 71.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:82.00 stddev:11.92 (14.5%) stddev-sans-first:12.14 13:47:34 INFO - PROCESS | 2242 | Values: 82.0 85.0 99.0 107.0 109.0 105.0 82.0 82.0 82.0 82.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:140.00 stddev:13.28 (9.5%) stddev-sans-first:13.25 13:47:34 INFO - PROCESS | 2242 | Values: 131.0 138.0 137.0 136.0 135.0 149.0 157.0 141.0 175.0 139.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:169.50 stddev:3.16 (1.9%) stddev-sans-first:3.28 13:47:34 INFO - PROCESS | 2242 | Values: 170.0 170.0 174.0 164.0 164.0 168.0 168.0 169.0 170.0 165.0 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - PROCESS | 2242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:73.00 stddev:14.43 (19.8%) stddev-sans-first:14.71 13:47:34 INFO - PROCESS | 2242 | Values: 69.0 67.0 68.0 68.0 76.0 96.0 102.0 99.0 89.0 70.0 13:47:34 INFO - PROCESS | 2242 | -------- Summary: end -------- 13:47:34 INFO - PROCESS | 2242 | 13:47:34 INFO - TEST-INFO | 2242: exit 0 13:47:34 INFO - TEST-OK | kraken | took 58832ms 13:47:34 INFO - SUITE-END | took 1174s 13:47:35 INFO - Completed test suite (00:19:35) 13:47:35 INFO - javascript benchmark 13:47:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2720.741529554692, 3346.7155291800195, 3370.7471939604534, 3387.847546860391, 3428.3314753623054, 5566.721663916798, 5574.86062848429, 5638.295213098363, 5666.291713535808, 5693.231413759147, 5602.719864006804, 5605.5515558755305, 5658.179563963233, 5661.971690141543, 5669.177969194464, 5147.665401748893, 5156.716380599066, 5162.303089082963, 5187.247849061884, 5228.764705588239, 5241.030409374259, 5247.501487358714, 5255.474452554752, 5261.605379596526, 5263.76313065911, 5112.309838171855, 5171.120909445403, 5181.222816577506, 5196.324477817879, 5236.816711415101, 5192.844214673547, 5237.869053273661, 5238.13570760824, 5238.188080847474, 5283.524482796528, 5047.3438453001245, 5109.642325037249, 5145.794168233266, 5148.021875843578, 5171.095058364771, 5395.028894798935, 5412.242286079952, 5493.807716729935, 5527.723613819293, 5553.250311208016, 6193.628382297032, 6203.5037197024585, 6203.720832562501, 6212.378762123797, 6217.751289948396, 6159.538034647419, 6256.1866957295715, 6258.405451482102, 6263.029230469285, 6274.623522588614, 5626.127950167731, 5632.802851900205, 5711.600187986843, 5770.798022069207, 5782.7686892523825, 6277.05844123376, 6323.20959880015, 6323.241211054611, 6334.904976425358, 6340.080688300263, 6081.604695694766, 6103.206583144251, 6103.35914728956, 6105.114758360013, 6114.755409783648, 5870.6771127587535, 5883.382244864313, 5951.613145145551, 5953.583249172603, 5955.13650520672, 6089.51283897296, 6139.916955224815, 6145.108959200891, 6145.924463218918, 6178.073289006685, 6121.602095863755, 6157.076438534255, 6165.0444181152, 6182.443580077815, 6183.103449999815, 4751.216049351888, 4816.90711662686, 4866.6106711463, 4879.316895634614, 4906.803727850846, 4421.579949904753, 4459.554044595579, 4461.353103799996, 4464.955350446519, 4499.977500112544, 5642.097264437671, 5654.15187721845, 5662.57530685192, 5671.092625179951, 5681.801136960269, 6194.473469755121, 6242.219722534684, 6252.656103914237, 6255.218097737783, 6261.0, 5578.63738856973, 5644.491995720323, 5677.290338707661, 5679.659220446786, 5686.516646085046, 5301.893962120736, 5351.812686555952, 5355.169948657965, 5363.356397232357, 5368.141097424394, 6276.184096067482, 6293.118963345227, 6300.0, 6306.873862522724, 6307.337729538424, 4399.49405818335, 6070.666113363807, 6125.632272693224, 6208.50331973432, 6225.190725205694, 6275.246970363585, 6287.371262873676, 6290.087937248982, 6337.04944258365, 6339.080833279241, 5172.818951336685, 6115.174451448997, 6115.357887421935, 6133.754649813957, 6155.261368635793, 4770.403699537558, 6081.969590152021, 6158.353372895782, 6172.8765424690355, 6244.906326405016, 6054.182685337423, 6071.150038994632, 6081.483073938588, 6081.939180608314, 6117.510599152146, 6033.577649564489, 6045.78839740607, 6051.092336149437, 6058.5153187745755, 6063.757449701962, 5739.799107031234, 5793.391693872251, 5846.824595262149, 5877.853053673693, 5891.764329426775, 6019.1573179754, 6074.939250607614, 6078.422549857756, 6086.969565152323, 6095.0, 5892.823215303548, 5904.468597826216, 5929.555283353679, 5933.732982015906, 5972.522198224045], "value": 5630.41989179973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.45528646132493, 506.36704119850185, 515.8504033830189, 521.530622439804, 531.7288183026658, 28422.715772842264, 31299.217519562022, 31305.530417043734, 31331.37337253259, 31418.842905785437, 31503.527447088312, 33205.0, 39596.40605390922, 40702.0, 40778.98052548688, 9484.336096473233, 9687.418754874694, 9688.66089686861, 9694.272929530278, 9694.369865958726, 8427.325813934902, 9441.905580944205, 9618.663346782863, 9635.421874687541, 9650.951745241264, 8644.265237454792, 11169.553217871275, 11375.829362559569, 11400.486978085964, 11402.0, 11403.3728144952, 11568.826467602992, 11574.942125289319, 11577.594784182513, 11592.652220433443, 8388.412811103226, 11089.500972456259, 11251.887481125248, 11371.772564548663, 11454.713632159262, 38960.22079558421, 39434.80282598597, 39516.407253891215, 39535.8023209885, 39541.0, 3224.742020638343, 3363.9831800841084, 3513.350030244387, 3544.929101417957, 3909.463999483898, 27718.86140569284, 28067.719322806715, 28082.297942551395, 28380.290492737848, 28701.85192592294, 2690.233283514209, 2717.3342531079816, 2733.740294672003, 2758.2966343582457, 2783.7772978161697, 488227.0, 490426.0, 490624.0, 492279.0, 492694.0, 48755.51244487581, 56988.71505642445, 58176.418235817946, 58227.12659310114, 58259.70870145622, 61152.69423652942, 61464.69267653633, 61680.69159654173, 61689.0, 61706.69146654238, 13597.456101756017, 16480.83519164817, 16564.58588535272, 16724.6655066898, 16739.414120505724, 12872.098953073195, 12939.935300323437, 12983.35083245853, 13062.085654004128, 13315.134516256412, 15585.922070389575, 15605.141717205435, 17079.31682732677, 17712.202950867242, 18038.458846234633, 6146.955017647011, 6922.757703480454, 7133.536320139175, 7153.6780844862105, 7216.097987751531, 941.9576119074521, 967.99032009679, 970.1913652968483, 1018.1294992781213, 1082.1667316166665, 29179.708202918122, 29428.705712943025, 29721.811127554654, 30347.0, 30588.0, 1100.4772732951944, 1100.8018556659717, 1149.0, 1160.5531870229854, 1184.5735535207318, 14861.0, 15245.009074410127, 15278.006929549543, 15339.463118790789, 15417.074975501506, 625694.2014058973, 633798.0, 635486.0, 636225.0, 637268.0, 60885.69557152186, 62265.44336391536, 62344.68827655833, 62436.687816560625, 62917.0, 1282.24347634894, 1461.8318893327403, 1487.4496436318632, 1490.046370322994, 1491.8284397294233, 24626.138085166935, 29250.829966801943, 29552.261193470335, 29672.55491167591, 30072.646730896726, 53732.0, 54288.45711542834, 54604.726976364866, 54665.90668186694, 54700.0, 575446.0, 578981.0, 579354.0, 579967.1001644965, 580209.0, 22566.5486690262, 25294.620580690935, 25770.484590307715, 25866.482670346864, 26294.4741105173, 39103.0, 39212.60787392204, 42493.362599560416, 43976.12047759091, 44041.339379909965, 34544.136396590286, 36950.0, 37111.814440928705, 37525.81237093797, 37819.81090094532, 34677.653223467445, 36324.27351453009, 36645.45031824578, 37335.253294933405, 37523.624763753105, 35772.0, 36073.81963090168, 36630.8168459156, 36795.08012299714, 36900.26199476049, 31280.530792037684, 31750.523742143425, 31881.043568692978, 32513.674863251064, 32882.17794555155, 24646.876765616056, 24662.0, 24752.876235619427, 24774.0, 24925.376865578506], "value": 19607.861266219265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.7936217631597, 361.5859840482647, 401.0715194325137, 407.079999201804, 407.2384640721851, 19920.70118948215, 21528.138874445023, 21569.352919412402, 21627.567448651018, 22647.54704905901, 19808.504787380323, 20803.0, 20809.583808323823, 21418.785812141872, 22473.438164045867, 5018.197088465846, 5284.706726171501, 5507.118860982244, 5507.146392309199, 5512.448755124496, 3240.400525902704, 4120.19656167046, 4139.3583994480905, 5437.755301011464, 5448.0, 4066.5323487798987, 4136.7176175385575, 5773.191753154561, 6104.847378815521, 6126.571140020201, 5724.22722932405, 6069.6054756441135, 6069.817905462799, 6087.634741915477, 6104.450599446049, 5814.418558144152, 5830.183774271605, 5831.18363429116, 5834.795782147647, 5836.095405212199, 13844.930775346058, 13869.37587808551, 13875.861241387558, 13896.444142234299, 14669.77995330071, 1970.290695349673, 2075.616011037963, 2123.0764617391483, 2146.9463263418384, 2212.9225477108384, 10412.94793526035, 10793.83809242862, 12759.787820157071, 14433.566992990121, 15204.695906081926, 1645.234965740936, 1712.8201538838366, 1726.6633006563725, 1772.503698964292, 1807.5752198233404, 120326.0, 120467.0, 122074.0, 123708.0, 126171.36914315462, 9489.715308540755, 11444.54221831134, 11772.823407648892, 11837.526498939946, 11911.761764764657, 15374.923125384525, 15500.5349839505, 15504.767428488582, 15533.301001454736, 15581.454649087227, 8831.558422078999, 8891.066438024043, 8917.28661707075, 8929.508877011827, 8995.055519170524, 7140.0, 8788.560571971377, 8834.602442890086, 8918.643254269886, 8936.151065648754, 4673.462551806586, 4731.266653668618, 4740.502247264057, 4747.0, 4772.7136371817805, 1700.4558541266676, 1760.8631194345433, 1838.6046999895086, 1899.0, 1992.8405727541763, 770.3452065744185, 891.2468963725642, 898.8831451911341, 944.5749412764284, 1021.3157184686278, 17354.566135846704, 20211.292604758764, 20984.79015209859, 21294.148234070773, 21349.78650213509, 808.4017826808238, 935.9859602105973, 944.9480278584606, 966.994325901069, 973.9513024348896, 9788.55951482185, 10800.567977280978, 10823.080038196842, 10899.83650245247, 10907.890921090846, 243716.0, 244371.0, 545379.5462045408, 593395.0, 600021.0, 130587.34706326408, 138229.3088534551, 141892.0, 142958.2852085733, 145461.54538454692, 891.8573028315438, 935.5462600638684, 1031.28841099641, 1069.5294070608907, 1090.1032203965044, 13868.653283667989, 17525.298988040337, 19239.230430783173, 19489.902550487157, 19597.0, 36372.63528376612, 46614.30078548892, 52019.2197117036, 52928.94142117213, 54324.45675543194, 70364.0, 75081.0, 76164.0, 77006.2299376999, 78735.0, 7944.960275198587, 8038.356931445353, 8273.793155171168, 8354.5405002723, 8680.78298042554, 6929.618870962146, 12122.575709850113, 12318.0, 12773.2336059833, 13105.27920964356, 7273.418126549969, 10817.0, 11240.775184496428, 11297.322160670386, 11533.480993355486, 10847.783044339227, 11042.17183711241, 11072.0, 11262.436878155895, 11356.716082098013, 11083.279586827153, 11277.266977646426, 11556.075513959031, 11601.883981160081, 11719.06247500215, 8312.044114926619, 8327.791805204919, 8526.957365213135, 8561.48631082137, 8576.614052367784, 10578.8413173804, 11283.492242849255, 11396.08831293478, 11407.828882566933, 11636.709082273012], "value": 9261.82505261894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.0201063276982, 1612.065002298667, 1618.417369746891, 1875.4748670372292, 1984.0972357577295, 7814.531128132316, 8615.095414981422, 8873.467591944487, 8878.911210887889, 8891.64433422664, 8462.576871156449, 8682.218600325969, 8685.34859885508, 8689.174528419806, 8701.608427620757, 2439.658447817307, 2474.6288056791536, 2476.0838489758817, 2477.541654793869, 2486.589712697403, 2402.315340128064, 2460.876956152194, 2463.5072985402903, 2470.765277298654, 2480.3009938192304, 2431.781139697427, 2457.8893949772214, 2465.8520488770732, 2472.4560596668794, 2476.7275599684112, 2430.3802530354733, 2440.1215562397524, 2454.398672325283, 2463.4457247119435, 2470.8270421070533, 2403.194929698553, 2437.9146729864547, 2440.804735621146, 2444.4866578018637, 2447.5839107351794, 8513.318934485227, 8661.220490155916, 8744.650213991432, 8747.956260218722, 8750.474971501666, 5237.869053273661, 5474.616776825624, 5491.121420572689, 5511.311086114236, 5519.116941289414, 3445.2937147884622, 3627.8911632650797, 3659.963400365989, 3668.192997540537, 3729.962700372989, 1042.6298663974333, 1062.6865074802874, 1064.11678307005, 1071.089573862211, 1072.469127781753, 11300.94349528247, 11399.886001140048, 11413.029892459152, 11425.0, 11437.142214333959, 4543.931841022388, 4555.316702494586, 4652.813887444532, 4676.205045142334, 4682.719036857799, 7987.440879138405, 9109.77018102561, 9222.985471598118, 9233.261339092856, 9248.491332976751, 5281.656692315064, 5303.602229832778, 5312.389075256395, 5313.0967735485065, 5321.547668448148, 3901.297766402018, 4400.669949753717, 4584.885377865513, 4881.707097574157, 4953.0930591722445, 3856.5179352580926, 3895.3962135868987, 3926.5079269877833, 3950.170464202492, 3965.841366345314, 1216.9878301217052, 1223.5534030078957, 1229.8524177098805, 1234.456838990841, 1235.184778046485, 656.3534918105662, 728.5337384074197, 886.7118186589385, 900.5407242306339, 986.4475893499663, 5051.393832740095, 5411.269478620336, 5581.162825576115, 5880.794172203952, 5883.352831188566, 1013.1185868294631, 1014.1937159957852, 1045.5190612318418, 1071.346478648024, 1071.8981696738797, 3373.0, 4027.6979226558124, 4033.776259743639, 4091.468109145792, 4106.958930410718, 10439.895601044043, 10891.945540272249, 10958.506867190996, 10971.39657318839, 10999.34003959765, 10785.83821242682, 10841.457927103613, 10878.510467029002, 10893.673189804318, 10943.960323769388, 8163.346932245406, 8324.417290789586, 8338.166183381612, 8343.332533397313, 8345.66617335312, 5708.714564271687, 5864.765409383577, 5875.559333050124, 5968.31364393083, 6117.571769976059, 9436.433813971184, 9771.12059914611, 10057.24570657189, 10064.748381290527, 10130.240231982778, 9936.850947235653, 10030.749231269278, 10113.988601139827, 10151.340162889388, 10154.644587439405, 7423.925760742323, 7483.70065197386, 7514.549127052176, 7632.923670763222, 7638.274363935418, 8197.590120494071, 8213.301869340934, 8304.252617264476, 8305.211004954519, 8306.70926517569, 6159.353267906985, 7380.18817930038, 7579.204183560647, 7644.426667999811, 7659.310662040443, 7272.454565907472, 7398.297161769623, 7450.739224127129, 7512.436567257369, 7528.774136775905, 6978.79063628092, 7011.26381729911, 7111.395531379684, 7113.217546070032, 7116.715331386687, 4853.126437241331, 4875.146849301429, 5004.599632029356, 5074.923876141787, 5245.160774276097, 4981.4769449207315, 5031.421386540448, 5089.13484707608, 5142.717150556755, 5316.255724198538], "value": 4605.730327381576, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.9801762885412, 315.82629553745437, 323.2742493102984, 324.31893024648235, 325.9348130373924, 4688.859334219975, 5143.305653736745, 5283.943211357725, 5348.277982472365, 5348.652337598053, 5000.349744686381, 5305.734713264341, 5307.25698402223, 5317.308749862513, 5324.361076670795, 4003.7397569158056, 4095.6279646318517, 4099.508059032905, 4131.731437456563, 4145.875623731293, 3234.4016356973916, 3885.3977633466857, 4131.19079026262, 4165.458490396244, 4186.35111557709, 3362.6132994705677, 3532.664396882305, 3721.4789929409903, 3935.3309937310582, 4025.5974402559805, 4010.5788892166192, 4042.402261986834, 4079.938800917989, 4080.224757296104, 4085.632293093606, 3528.8412021459094, 3535.805530695811, 3542.5040494330815, 3546.6098729139776, 3563.7149028077692, 4597.42532183477, 4791.897863491382, 4870.878228044292, 5112.156494178456, 5136.5890728741615, 3677.8344974476213, 4144.7513149210845, 4185.686073544496, 4516.93851944796, 4597.7011494252765, 4818.180909245437, 5512.862178445571, 5514.476124768141, 5534.529564986981, 5544.08935308962, 3529.6470352964757, 3561.358955388055, 3676.4485327201132, 3849.615038496128, 3855.826487808027, 4587.747673877969, 5710.343310519302, 5757.712114394263, 5822.0684690449325, 5823.737931793079, 3344.6153692325206, 3882.2235552889533, 3885.592012838668, 3902.785346805953, 3924.372100463912, 3155.936881262408, 3258.3483303339426, 3637.5816781070516, 3736.103335199587, 3976.4234186042863, 3745.4943582616543, 4075.7962101894786, 4516.254817955067, 4562.908741825145, 4562.954370456319, 5344.0, 5546.445355464502, 5584.86037849057, 5610.859728506738, 5614.803481878196, 1390.958271251864, 1413.194479146897, 1448.5654303708845, 1458.431211827388, 1463.3122432456728, 738.9889151662729, 864.3301441382853, 898.766320756608, 940.6284517615503, 943.7687766497252, 4773.920821070459, 5246.213068039825, 5461.1262198048125, 5731.541476681939, 5745.195672605839, 5036.5718913892, 5169.0, 5207.713575753294, 5300.496452836975, 5348.010618035676, 4830.9371938173545, 4972.477889821589, 5228.555572776357, 5433.8369848904595, 5701.2588363513305, 2993.416283824677, 3260.7717459778064, 3307.503874418808, 3313.353895990259, 3314.4919061826813, 6190.2571691397325, 6409.198850143732, 6566.737330506726, 6568.35456321746, 6589.868202636017, 5272.544699728723, 5649.0396632572565, 6038.33578306386, 6040.969795150996, 6054.666993315322, 4834.806607735652, 5489.92946375453, 5570.749316280858, 5964.194833697482, 6057.666828324396, 4797.544233297831, 5411.567074634098, 5759.211991948233, 5800.906085465899, 5927.6662750880705, 5725.770969161354, 5738.397468265772, 5739.397363276796, 5763.366029736641, 5763.4812866842185, 4759.690620109682, 5351.725516655328, 5563.666180029211, 5903.616264942937, 6006.288207860739, 3341.9138779897116, 3470.5661792275964, 3657.158853463665, 3984.442178095011, 3989.0426297688928, 4582.793774280099, 4690.35837456901, 5887.028640274478, 5900.468957793819, 5924.755801281779, 4655.557722016403, 5586.720663966704, 5670.121131224667, 5736.340320863154, 5737.827865164052, 5150.0, 5643.4886475518, 5649.830505084854, 5675.659460432387, 5794.3626201117, 4425.269830477935, 5232.947670523398, 5413.215083812904, 5647.463490968352, 5655.0, 4854.980454104678, 4963.0, 5481.409676661793, 5642.88714225705, 5661.490465858093, 5206.392342776746, 5609.775608975595, 5621.381648018796, 5639.182318563868, 5674.631148975303], "value": 4098.970398006936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.3449748505265, 672.2537982839049, 680.9625470599118, 732.7567000202991, 739.9388184815858, 13712.520061797839, 14309.499167529139, 14788.77816832747, 15383.230838458074, 15403.152826594533, 11027.0, 14857.182854943001, 15376.308066137022, 15455.149966751824, 16156.788240881922, 933.4259430450259, 940.1022023967129, 942.6182396129578, 942.8067246214544, 946.7207173883721, 736.1718067174429, 903.1465265324272, 918.2608000559546, 940.1538615246264, 940.4310392212716, 984.2618036472645, 989.2481713897417, 990.8018396320729, 991.2218908157098, 991.33085167512, 975.1272611013139, 982.8378317577591, 983.1397527163732, 984.8768903887014, 986.146982859821, 723.3851226457522, 724.5652608434949, 724.9057622509093, 726.7347418192322, 729.8467321862415, 14562.053466524749, 14876.479323223744, 14877.404903803943, 14883.77674334875, 14981.0, 12257.325847078408, 12387.442565084593, 12406.689832754164, 12518.436670349765, 12574.308413037279, 9027.368084234105, 9196.356255062148, 9301.90698093017, 9355.719328420158, 9473.478958657272, 3431.3823511767873, 3448.448248280288, 3495.3358861816428, 3518.577770667511, 3572.214112895185, 71702.28297717008, 72318.63840680815, 72328.6383568084, 72404.27595724029, 77028.61485692592, 9246.925081076255, 9328.906710932939, 9398.765030874283, 9465.90534094664, 9584.856227156599, 21423.357299281048, 21492.677609835864, 21503.89248053781, 21529.892350538146, 21539.56920861574, 7095.89356159658, 7113.53762005468, 7236.457265704988, 7279.381252593483, 7400.555966642019, 3909.2181563687377, 3986.342253528135, 4000.3599424092586, 4004.2992476316526, 4006.959930400717, 3403.4724617684296, 3514.683678468899, 3514.9824250878582, 3526.5062891195253, 3527.6295988920792, 573.6147204501083, 627.8430392401899, 640.145405883142, 645.602954183174, 657.5298661457081, 495.7446914838861, 547.6850810783815, 586.5073338395769, 595.1548800702925, 606.8968275393194, 7722.845543089107, 8004.479708818908, 8031.196880311922, 8121.106678265386, 8250.339972802161, 553.6760994817996, 587.9470847623735, 595.9493443057389, 610.0574612224125, 624.8437890527368, 3646.7629604076183, 3863.459115723801, 3898.7660740355104, 3902.083010492532, 3941.980290098531, 88731.0, 92163.07836921679, 92509.5374523123, 94815.57776633356, 99959.50020249997, 52108.0, 72540.0, 78593.0, 82487.17512824915, 86099.65200728734, 64304.713905721626, 65689.0293291202, 65886.34113658898, 66627.66686166635, 74817.0, 6527.0, 7975.920240797518, 8099.14958929304, 8158.0, 8257.516463685202, 41791.79104104581, 42235.73292801221, 42434.787826060674, 43410.69767906968, 44292.4497642581, 57727.55681107838, 58199.4180058194, 58689.0, 61911.38088619236, 63019.6849015752, 8803.60383782744, 10667.626633067805, 10752.784944300915, 10931.83602245983, 11215.943920280346, 11901.702457438634, 11913.880861191277, 11981.221220620631, 12390.62828115158, 12761.61715148547, 9535.761605959906, 11234.775304494027, 11568.826467602825, 12011.399430028638, 12315.815262770886, 11109.888901110886, 11323.716907077389, 11515.884841151481, 11624.302541847515, 12195.817062743889, 11164.106871450102, 11238.943805280922, 11402.714932126763, 11450.82823757661, 12192.207506512048, 9294.953525232331, 9400.95299523498, 9716.0, 9738.172255358373, 10506.737331566466, 7770.922290777246, 8723.302135829246, 8744.91255087441, 8818.11818818113, 9364.81270374575], "value": 6767.796118021465, "unit": "score"}], "name": "dromaeo_css", "value": 7123.424388549249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 106.0, 112.0, 115.0, 159.0, 167.0, 113.0, 106.0, 112.0], "value": 121.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 146.0, 174.0, 120.0, 141.0, 126.0, 125.0, 209.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 184.0, 186.0, 187.0, 185.0, 184.0, 185.0, 185.0, 185.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 89.0, 92.0, 57.0, 58.0, 57.0, 83.0, 88.0, 55.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 134.0, 79.0, 77.0, 80.0, 126.0, 79.0, 76.0, 130.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 88.0, 83.0, 87.0, 86.0, 88.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 93.0, 92.0, 92.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 87.0, 89.0, 88.0, 87.0, 100.0, 86.0, 93.0, 144.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 59.0, 59.0, 61.0, 60.0, 59.0, 75.0, 61.0, 59.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 80.0, 79.0, 69.0, 70.0, 67.0, 69.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 99.0, 107.0, 109.0, 105.0, 82.0, 82.0, 82.0, 82.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 137.0, 136.0, 135.0, 149.0, 157.0, 141.0, 175.0, 139.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 174.0, 164.0, 164.0, 168.0, 168.0, 169.0, 170.0, 165.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 76.0, 96.0, 102.0, 99.0, 89.0, 70.0], "value": 80.4, "unit": "score"}], "name": "kraken", "value": 1514.9, "alertThreshold": 2.0}]} 13:47:35 INFO - Return code: 0 13:47:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:47:35 ERROR - # TBPL SUCCESS # 13:47:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:47:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:47:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:47:35 INFO - 2016-04-29 13:47:35.337 screenresolution[2246:70205] starting screenresolution argv=screenresolution get 13:47:35 INFO - 2016-04-29 13:47:35.340 screenresolution[2246:70205] Display 0: 1600x1200x32@60 13:47:35 INFO - 2016-04-29 13:47:35.346 screenresolution[2247:70208] starting screenresolution argv=screenresolution list 13:47:35 INFO - Available Modes on Display 0 13:47:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:47:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:47:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:47:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:47:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:47:35 INFO - Intel Iris: 13:47:35 INFO - Chipset Model: Intel Iris 13:47:35 INFO - Type: GPU 13:47:35 INFO - Bus: Built-In 13:47:35 INFO - VRAM (Dynamic, Max): 1536 MB 13:47:35 INFO - Vendor: Intel (0x8086) 13:47:35 INFO - Device ID: 0x0a2e 13:47:35 INFO - Revision ID: 0x0009 13:47:35 INFO - Displays: 13:47:35 INFO - Display: 13:47:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:47:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:47:35 INFO - Display Serial Number: 1600x1200 60 13:47:35 INFO - Main Display: Yes 13:47:35 INFO - Mirror: Off 13:47:35 INFO - Online: Yes 13:47:35 INFO - Rotation: Supported 13:47:35 INFO - Return code: 0 13:47:35 INFO - Running post-action listener: _resource_record_post_action 13:47:35 INFO - Running post-run listener: _resource_record_post_run 13:47:36 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 114688; Write bytes: 694350336; Read time: 3; Write time: 2105 13:47:36 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387207680; Write bytes: 381625856; Read time: 30167; Write time: 688 13:47:36 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 114688; Write bytes: 294988800; Read time: 3; Write time: 1376 13:47:36 INFO - Running post-run listener: _upload_blobber_files 13:47:36 INFO - Blob upload gear active. 13:47:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:36 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 13:47:36 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'] 13:47:36 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 13:47:37 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:37 INFO - (blobuploader) - INFO - Done attempting. 13:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:47:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:38 INFO - (blobuploader) - INFO - Done attempting. 13:47:38 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:38 INFO - Return code: 0 13:47:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1fb5418f4a104beda89dd99d6bfdfaf0b058928ff31a149570494452bfd5c717d1bdc4aad44376f4e32a43a1b5d91a57038555aacb7ba473eaad5b0a78cc3de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4acd929796eac362c85c7a74757f8ccc900a75523b9eaa3f0b8f0745e9d4a07e4b74870dbf16184bc54ec3726296bedd206ffa5a771ca4e9f4a594841c2dadf9"} 13:47:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:38 INFO - Contents: 13:47:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1fb5418f4a104beda89dd99d6bfdfaf0b058928ff31a149570494452bfd5c717d1bdc4aad44376f4e32a43a1b5d91a57038555aacb7ba473eaad5b0a78cc3de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4acd929796eac362c85c7a74757f8ccc900a75523b9eaa3f0b8f0745e9d4a07e4b74870dbf16184bc54ec3726296bedd206ffa5a771ca4e9f4a594841c2dadf9"} 13:47:38 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:38 INFO - Copying logs to upload dir... 13:47:38 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.823118 ========= master_lag: 3.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-29 13:47:41.798800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-29 13:47:41.806620) ========= 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.wXFoYLLdup/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.vA1NhJqEgi/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1fb5418f4a104beda89dd99d6bfdfaf0b058928ff31a149570494452bfd5c717d1bdc4aad44376f4e32a43a1b5d91a57038555aacb7ba473eaad5b0a78cc3de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4acd929796eac362c85c7a74757f8ccc900a75523b9eaa3f0b8f0745e9d4a07e4b74870dbf16184bc54ec3726296bedd206ffa5a771ca4e9f4a594841c2dadf9"} build_url:https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/bEWGHKSqRWOp_g1MErdWoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1fb5418f4a104beda89dd99d6bfdfaf0b058928ff31a149570494452bfd5c717d1bdc4aad44376f4e32a43a1b5d91a57038555aacb7ba473eaad5b0a78cc3de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4acd929796eac362c85c7a74757f8ccc900a75523b9eaa3f0b8f0745e9d4a07e4b74870dbf16184bc54ec3726296bedd206ffa5a771ca4e9f4a594841c2dadf9"}' ========= master_lag: 1.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-29 13:47:43.072681) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:47:43.073064) ========= 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.wXFoYLLdup/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.vA1NhJqEgi/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005380 ========= master_lag: 0.81 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:47:43.884886) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:47:43.889254) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:47:44.057117) ========= ========= Total master_lag: 5.28 =========