builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1463463614.32 results: success (0) buildid: 20160516203739 builduid: 35109f84dca34c5782941e77d47db877 revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.315715) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.316131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.316417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.336568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.336857) ========= 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.VNsWVspbr0/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.DOlwk9DlGm/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-05-16 22:40:14-- 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% 173M=0s 2016-05-16 22:40:14 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.485013 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.839192) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.839495) ========= 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.VNsWVspbr0/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.DOlwk9DlGm/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.027334 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:14.888537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 22:40:14.888890) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9598d922a0ba3957d4cf178a03b877d76354fb1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9598d922a0ba3957d4cf178a03b877d76354fb1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VNsWVspbr0/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.DOlwk9DlGm/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-05-16 22:40:14,962 truncating revision to first 12 chars 2016-05-16 22:40:14,962 Setting DEBUG logging. 2016-05-16 22:40:14,962 attempt 1/10 2016-05-16 22:40:14,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b9598d922a0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 22:40:16,140 unpacking tar archive at: mozilla-beta-b9598d922a0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430625 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 22:40:16.354529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:16.354825) ========= script_repo_revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 22:40:16.355181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-05-16 22:40:16.355436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-05-16 22:40:18.007691) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-05-16 22:40:18.008027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VNsWVspbr0/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.DOlwk9DlGm/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:40:18 INFO - MultiFileLogger online at 20160516 22:40:18 in /builds/slave/test 22:40:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:40:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:40:18 INFO - {'append_to_log': False, 22:40:18 INFO - 'base_work_dir': '/builds/slave/test', 22:40:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:40:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:40:18 INFO - 'branch': 'Mozilla-Beta', 22:40:18 INFO - 'buildbot_json_path': 'buildprops.json', 22:40:18 INFO - 'config_files': ('talos/mac_config.py',), 22:40:18 INFO - 'default_actions': ('clobber', 22:40:18 INFO - 'read-buildbot-config', 22:40:18 INFO - 'download-and-extract', 22:40:18 INFO - 'populate-webroot', 22:40:18 INFO - 'create-virtualenv', 22:40:18 INFO - 'install', 22:40:18 INFO - 'run-tests'), 22:40:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:40:18 INFO - 'download_minidump_stackwalk': True, 22:40:18 INFO - 'download_symbols': 'ondemand', 22:40:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:40:18 INFO - 'tooltool.py': '/tools/tooltool.py', 22:40:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:40:18 INFO - '/tools/misc-python/virtualenv.py')}, 22:40:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:40:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:40:18 INFO - 'installer_path': 'installer.exe', 22:40:18 INFO - 'log_level': 'info', 22:40:18 INFO - 'log_name': 'talos', 22:40:18 INFO - 'log_to_console': True, 22:40:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:40:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:40:18 INFO - 'opt_config_files': (), 22:40:18 INFO - 'pip_index': False, 22:40:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:40:18 INFO - 'cmd': ('bash', 22:40:18 INFO - '-c', 22:40:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:40:18 INFO - 'enabled': True, 22:40:18 INFO - 'halt_on_failure': False, 22:40:18 INFO - 'name': 'check_screen_resolution'},), 22:40:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:40:18 INFO - 'cmd': ('bash', 22:40:18 INFO - '-c', 22:40:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:40:18 INFO - 'enabled': True, 22:40:18 INFO - 'halt_on_failure': False, 22:40:18 INFO - 'name': 'check_screen_resolution'},), 22:40:18 INFO - 'run_cmd_checks_enabled': True, 22:40:18 INFO - 'sps_profile': False, 22:40:18 INFO - 'sps_profile_interval': 0, 22:40:18 INFO - 'suite': 'dromaeojs', 22:40:18 INFO - 'system_bits': '32', 22:40:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:40:18 INFO - 'title': 't-yosemite-r7-0037', 22:40:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:40:18 INFO - 'use_talos_json': True, 22:40:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:40:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:40:18 INFO - 'work_dir': 'build'} 22:40:18 INFO - ##### 22:40:18 INFO - ##### Running clobber step. 22:40:18 INFO - ##### 22:40:18 INFO - Running pre-action listener: _resource_record_pre_action 22:40:18 INFO - Running main action method: clobber 22:40:18 INFO - rmtree: /builds/slave/test/build 22:40:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:40:20 INFO - Running post-action listener: _resource_record_post_action 22:40:20 INFO - ##### 22:40:20 INFO - ##### Running read-buildbot-config step. 22:40:20 INFO - ##### 22:40:20 INFO - Running pre-action listener: _resource_record_pre_action 22:40:20 INFO - Running main action method: read_buildbot_config 22:40:20 INFO - Using buildbot properties: 22:40:20 INFO - { 22:40:20 INFO - "project": "", 22:40:20 INFO - "product": "firefox", 22:40:20 INFO - "script_repo_revision": "production", 22:40:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 22:40:20 INFO - "repository": "", 22:40:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 22:40:20 INFO - "buildid": "20160516203739", 22:40:20 INFO - "pgo_build": "False", 22:40:20 INFO - "basedir": "/builds/slave/test", 22:40:20 INFO - "buildnumber": 19, 22:40:20 INFO - "slavename": "t-yosemite-r7-0037", 22:40:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:40:20 INFO - "platform": "yosemite_r7", 22:40:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 22:40:20 INFO - "branch": "mozilla-beta", 22:40:20 INFO - "repo_path": "releases/mozilla-beta", 22:40:20 INFO - "revision": "b9598d922a0ba3957d4cf178a03b877d76354fb1", 22:40:20 INFO - "stage_platform": "macosx64", 22:40:20 INFO - "builduid": "35109f84dca34c5782941e77d47db877", 22:40:20 INFO - "slavebuilddir": "test" 22:40:20 INFO - } 22:40:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 22:40:20 INFO - Running post-action listener: _resource_record_post_action 22:40:20 INFO - ##### 22:40:20 INFO - ##### Running download-and-extract step. 22:40:20 INFO - ##### 22:40:20 INFO - Running pre-action listener: _resource_record_pre_action 22:40:20 INFO - Running main action method: download_and_extract 22:40:20 INFO - mkdir: /builds/slave/test/build/tests 22:40:20 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')]} 22:40:20 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:40:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 22:40:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 22:40:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 22:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 22:40:36 INFO - Downloaded 1241 bytes. 22:40:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 22:40:36 INFO - Using the following test package requirements: 22:40:36 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 22:40:36 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 22:40:36 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 22:40:36 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:40:36 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 22:40:36 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 22:40:36 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 22:40:36 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 22:40:36 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 22:40:36 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 22:40:36 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 22:40:36 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 22:40:36 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 22:40:36 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')]} 22:40:36 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:40:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:40:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:40:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 22:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 22:40:42 INFO - Downloaded 17747789 bytes. 22:40:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:40:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:40:45 INFO - Return code: 0 22:40:45 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:40: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')]} 22:40:45 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 22:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 22:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 22:41:01 INFO - Downloaded 17747789 bytes. 22:41:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:41:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:41:04 INFO - Return code: 0 22:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:41:04 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:41:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 22:41:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 22:41:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 22:41:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 22:41:07 INFO - Downloaded 10845194 bytes. 22:41:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:41:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:41:08 INFO - Return code: 0 22:41:08 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')]} 22:41:08 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 22:41:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:41:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:41:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 22:41:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 22:41:17 INFO - Downloaded 88288778 bytes. 22:41:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:41:17 INFO - mkdir: /builds/slave/test/properties 22:41:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:41:17 INFO - Writing to file /builds/slave/test/properties/build_url 22:41:17 INFO - Contents: 22:41:17 INFO - build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 22:41:18 INFO - Running post-action listener: _resource_record_post_action 22:41:18 INFO - Running post-action listener: set_extra_try_arguments 22:41:18 INFO - ##### 22:41:18 INFO - ##### Running populate-webroot step. 22:41:18 INFO - ##### 22:41:18 INFO - Running pre-action listener: _resource_record_pre_action 22:41:18 INFO - Running main action method: populate_webroot 22:41:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:18 INFO - '--tppagecycles', 22:41:18 INFO - '7'], 22:41:18 INFO - 'tests': ['tsvgm']}}, 22:41:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:41:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:41:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'tests': ['damp', 'tps']}, 22:41:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['damp', 'tps']}, 22:41:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:41:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:18 INFO - 'other': {'tests': ['a11yr', 22:41:18 INFO - 'ts_paint', 22:41:18 INFO - 'tpaint', 22:41:18 INFO - 'sessionrestore', 22:41:18 INFO - 'sessionrestore_no_auto_restore', 22:41:18 INFO - 'tabpaint']}, 22:41:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['a11yr', 22:41:18 INFO - 'ts_paint', 22:41:18 INFO - 'tpaint', 22:41:18 INFO - 'sessionrestore', 22:41:18 INFO - 'sessionrestore_no_auto_restore', 22:41:18 INFO - 'tabpaint']}, 22:41:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['a11yr', 22:41:18 INFO - 'ts_paint', 22:41:18 INFO - 'tpaint', 22:41:18 INFO - 'sessionrestore', 22:41:18 INFO - 'sessionrestore_no_auto_restore', 22:41:18 INFO - 'tabpaint']}, 22:41:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['a11yr', 22:41:18 INFO - 'ts_paint', 22:41:18 INFO - 'tpaint', 22:41:18 INFO - 'sessionrestore', 22:41:18 INFO - 'sessionrestore_no_auto_restore', 22:41:18 INFO - 'tabpaint']}, 22:41:18 INFO - 'other_l64': {'tests': ['a11yr', 22:41:18 INFO - 'ts_paint', 22:41:18 INFO - 'tpaint', 22:41:18 INFO - 'sessionrestore', 22:41:18 INFO - 'sessionrestore_no_auto_restore', 22:41:18 INFO - 'tabpaint']}, 22:41:18 INFO - 'other_nol64': {'tests': ['a11yr', 22:41:18 INFO - 'ts_paint', 22:41:18 INFO - 'tpaint', 22:41:18 INFO - 'sessionrestore', 22:41:18 INFO - 'sessionrestore_no_auto_restore', 22:41:18 INFO - 'tabpaint']}, 22:41:18 INFO - 'svgr': {'tests': ['tsvgx', 22:41:18 INFO - 'tsvgr_opacity', 22:41:18 INFO - 'tart', 22:41:18 INFO - 'tscrollx', 22:41:18 INFO - 'cart']}, 22:41:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['tsvgx', 22:41:18 INFO - 'tsvgr_opacity', 22:41:18 INFO - 'tart', 22:41:18 INFO - 'tscrollx', 22:41:18 INFO - 'cart']}, 22:41:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'tests': ['tp5o']}, 22:41:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'talos_options': ['--e10s'], 22:41:18 INFO - 'tests': ['tp5o']}, 22:41:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'talos_options': ['--xperf_path', 22:41:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:18 INFO - 'tests': ['tp5n']}, 22:41:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:18 INFO - 'talos_options': ['--e10s', 22:41:18 INFO - '--xperf_path', 22:41:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:18 INFO - 'tests': ['tp5n']}}, 22:41:18 INFO - 'talos.zip': {'path': '', 22:41:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:18 INFO - Running post-action listener: _resource_record_post_action 22:41:18 INFO - ##### 22:41:18 INFO - ##### Running create-virtualenv step. 22:41:18 INFO - ##### 22:41:18 INFO - Running pre-action listener: _resource_record_pre_action 22:41:18 INFO - Running main action method: create_virtualenv 22:41:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:41:18 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 22:41:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:41:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:18 INFO - Using real prefix '/tools/python27' 22:41:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:41:19 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:22 INFO - Installing pip.................done. 22:41:22 INFO - Return code: 0 22:41:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:41:22 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')]} 22:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:22 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')]} 22:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:22 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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:22 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 22:41:22 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 22:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:22 INFO - 'HOME': '/Users/cltbld', 22:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:22 INFO - 'LOGNAME': 'cltbld', 22:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:22 INFO - 'MOZ_NO_REMOTE': '1', 22:41:22 INFO - 'NO_EM_RESTART': '1', 22:41:22 INFO - 'PAGER': '/bin/cat', 22:41:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:22 INFO - 'PWD': '/builds/slave/test', 22:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:22 INFO - 'SHELL': '/bin/bash', 22:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:22 INFO - 'USER': 'cltbld', 22:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:22 INFO - 'XPC_FLAGS': '0x0', 22:41:22 INFO - 'XPC_SERVICE_NAME': '0', 22:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:22 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 22:41:22 INFO - Cleaning up... 22:41:22 INFO - Return code: 0 22:41:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:41:22 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')]} 22:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:22 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')]} 22:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:22 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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:22 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 22:41:22 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 22:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:22 INFO - 'HOME': '/Users/cltbld', 22:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:22 INFO - 'LOGNAME': 'cltbld', 22:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:22 INFO - 'MOZ_NO_REMOTE': '1', 22:41:22 INFO - 'NO_EM_RESTART': '1', 22:41:22 INFO - 'PAGER': '/bin/cat', 22:41:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:22 INFO - 'PWD': '/builds/slave/test', 22:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:22 INFO - 'SHELL': '/bin/bash', 22:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:22 INFO - 'USER': 'cltbld', 22:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:22 INFO - 'XPC_FLAGS': '0x0', 22:41:22 INFO - 'XPC_SERVICE_NAME': '0', 22:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:23 INFO - Downloading/unpacking psutil>=0.7.1 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:41:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:26 INFO - Installing collected packages: psutil 22:41:26 INFO - Running setup.py install for psutil 22:41:26 INFO - building 'psutil._psutil_osx' extension 22:41:26 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 22:41:26 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 22:41:26 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 22:41:27 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 22:41:27 INFO - building 'psutil._psutil_posix' extension 22:41:27 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 22:41:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:41:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:41:27 INFO - ^ 22:41:27 INFO - 1 warning generated. 22:41:27 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 22:41:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:27 INFO - Successfully installed psutil 22:41:27 INFO - Cleaning up... 22:41:27 INFO - Return code: 0 22:41:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:27 INFO - 'HOME': '/Users/cltbld', 22:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:27 INFO - 'LOGNAME': 'cltbld', 22:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:27 INFO - 'MOZ_NO_REMOTE': '1', 22:41:27 INFO - 'NO_EM_RESTART': '1', 22:41:27 INFO - 'PAGER': '/bin/cat', 22:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:27 INFO - 'PWD': '/builds/slave/test', 22:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:27 INFO - 'SHELL': '/bin/bash', 22:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:27 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:27 INFO - 'USER': 'cltbld', 22:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:27 INFO - 'XPC_FLAGS': '0x0', 22:41:27 INFO - 'XPC_SERVICE_NAME': '0', 22:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:41:27 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 22:41:27 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 22:41:27 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 22:41:27 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 22:41:27 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 22:41:27 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 22:41:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:41:30 INFO - Installing collected packages: mozsystemmonitor 22:41:30 INFO - Running setup.py install for mozsystemmonitor 22:41:30 INFO - Successfully installed mozsystemmonitor 22:41:30 INFO - Cleaning up... 22:41:30 INFO - Return code: 0 22:41:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:41:30 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')]} 22:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:30 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')]} 22:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:30 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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:30 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 22:41:30 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 22:41:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:30 INFO - 'HOME': '/Users/cltbld', 22:41:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:30 INFO - 'LOGNAME': 'cltbld', 22:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:30 INFO - 'MOZ_NO_REMOTE': '1', 22:41:30 INFO - 'NO_EM_RESTART': '1', 22:41:30 INFO - 'PAGER': '/bin/cat', 22:41:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:30 INFO - 'PWD': '/builds/slave/test', 22:41:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:30 INFO - 'SHELL': '/bin/bash', 22:41:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:30 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:30 INFO - 'USER': 'cltbld', 22:41:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:30 INFO - 'XPC_FLAGS': '0x0', 22:41:30 INFO - 'XPC_SERVICE_NAME': '0', 22:41:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:30 INFO - Downloading/unpacking blobuploader==1.2.4 22:41:30 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 22:41:30 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 22:41:30 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 22:41:30 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 22:41:30 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 22:41:30 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 22:41:33 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:41:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 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 22:41:33 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 22:41:34 INFO - Downloading docopt-0.6.1.tar.gz 22:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:34 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:34 INFO - Running setup.py install for blobuploader 22:41:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:41:34 INFO - Running setup.py install for requests 22:41:35 INFO - Running setup.py install for docopt 22:41:35 INFO - Successfully installed blobuploader requests docopt 22:41:35 INFO - Cleaning up... 22:41:35 INFO - Return code: 0 22:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:35 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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:35 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 22:41:35 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 22:41:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:35 INFO - 'HOME': '/Users/cltbld', 22:41:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:35 INFO - 'LOGNAME': 'cltbld', 22:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:35 INFO - 'MOZ_NO_REMOTE': '1', 22:41:35 INFO - 'NO_EM_RESTART': '1', 22:41:35 INFO - 'PAGER': '/bin/cat', 22:41:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:35 INFO - 'PWD': '/builds/slave/test', 22:41:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:35 INFO - 'SHELL': '/bin/bash', 22:41:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:35 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:35 INFO - 'USER': 'cltbld', 22:41:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:35 INFO - 'XPC_FLAGS': '0x0', 22:41:35 INFO - 'XPC_SERVICE_NAME': '0', 22:41:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9Jnqba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-3IwdJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-xjLT5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-5nmjoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZgKGSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-EGseRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8DKBuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-k0Gl1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-VNdZtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-JNu6nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-swJaHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-95miXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tBwZOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:36 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-t4BeTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-az7RT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-M0CEsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:37 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-y9QInJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:37 INFO - Running setup.py install for manifestparser 22:41:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:41:37 INFO - Running setup.py install for mozcrash 22:41:37 INFO - Running setup.py install for mozdebug 22:41:37 INFO - Running setup.py install for mozdevice 22:41:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:41:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:41:37 INFO - Running setup.py install for mozfile 22:41:38 INFO - Running setup.py install for mozhttpd 22:41:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Running setup.py install for mozinfo 22:41:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Running setup.py install for mozInstall 22:41:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Running setup.py install for mozleak 22:41:38 INFO - Running setup.py install for mozlog 22:41:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Running setup.py install for moznetwork 22:41:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:41:38 INFO - Running setup.py install for mozprocess 22:41:39 INFO - Running setup.py install for mozprofile 22:41:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:41:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:41:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:41:39 INFO - Running setup.py install for mozrunner 22:41:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:41:39 INFO - Running setup.py install for mozscreenshot 22:41:39 INFO - Running setup.py install for moztest 22:41:39 INFO - Running setup.py install for mozversion 22:41:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:41:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:39 INFO - Cleaning up... 22:41:39 INFO - Return code: 0 22:41:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:39 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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:39 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 22:41:39 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 22:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:39 INFO - 'HOME': '/Users/cltbld', 22:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:39 INFO - 'LOGNAME': 'cltbld', 22:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:39 INFO - 'MOZ_NO_REMOTE': '1', 22:41:39 INFO - 'NO_EM_RESTART': '1', 22:41:39 INFO - 'PAGER': '/bin/cat', 22:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:39 INFO - 'PWD': '/builds/slave/test', 22:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:39 INFO - 'SHELL': '/bin/bash', 22:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:39 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:39 INFO - 'USER': 'cltbld', 22:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:39 INFO - 'XPC_FLAGS': '0x0', 22:41:39 INFO - 'XPC_SERVICE_NAME': '0', 22:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-usCz2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-5pTiO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-A1wgyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XzCe0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-NmYCM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jjIi3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-vkuQtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:40 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)) 22:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-IDYNXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qL8tvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-KbPrqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7XkqQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-xwPUsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-4470eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-BYtojx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pLA3CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Xr5kox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:41 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)) 22:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:41 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8lmewl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:41 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)) 22:41:41 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)) 22:41:41 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)) 22:41:41 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)) 22:41:41 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)) 22:41:41 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)) 22:41:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:41:41 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 22:41:41 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 22:41:41 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 22:41:41 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 22:41:41 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 22:41:41 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 22:41:44 INFO - Downloading blessings-1.6.tar.gz 22:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:41:44 INFO - Installing collected packages: blessings 22:41:44 INFO - Running setup.py install for blessings 22:41:44 INFO - Successfully installed blessings 22:41:44 INFO - Cleaning up... 22:41:44 INFO - Return code: 0 22:41:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:41:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:45 INFO - Reading from file tmpfile_stdout 22:41:45 INFO - Current package versions: 22:41:45 INFO - blessings == 1.6 22:41:45 INFO - blobuploader == 1.2.4 22:41:45 INFO - docopt == 0.6.1 22:41:45 INFO - manifestparser == 1.1 22:41:45 INFO - mozInstall == 1.12 22:41:45 INFO - mozcrash == 0.17 22:41:45 INFO - mozdebug == 0.1 22:41:45 INFO - mozdevice == 0.48 22:41:45 INFO - mozfile == 1.2 22:41:45 INFO - mozhttpd == 0.7 22:41:45 INFO - mozinfo == 0.9 22:41:45 INFO - mozleak == 0.1 22:41:45 INFO - mozlog == 3.1 22:41:45 INFO - moznetwork == 0.27 22:41:45 INFO - mozprocess == 0.22 22:41:45 INFO - mozprofile == 0.28 22:41:45 INFO - mozrunner == 6.11 22:41:45 INFO - mozscreenshot == 0.1 22:41:45 INFO - mozsystemmonitor == 0.0 22:41:45 INFO - moztest == 0.7 22:41:45 INFO - mozversion == 1.4 22:41:45 INFO - psutil == 3.1.1 22:41:45 INFO - requests == 1.2.3 22:41:45 INFO - wsgiref == 0.1.2 22:41:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:45 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 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:45 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 22:41:45 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 22:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:45 INFO - 'HOME': '/Users/cltbld', 22:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:45 INFO - 'LOGNAME': 'cltbld', 22:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:45 INFO - 'MOZ_NO_REMOTE': '1', 22:41:45 INFO - 'NO_EM_RESTART': '1', 22:41:45 INFO - 'PAGER': '/bin/cat', 22:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:45 INFO - 'PWD': '/builds/slave/test', 22:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:45 INFO - 'SHELL': '/bin/bash', 22:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:45 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:45 INFO - 'USER': 'cltbld', 22:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:45 INFO - 'XPC_FLAGS': '0x0', 22:41:45 INFO - 'XPC_SERVICE_NAME': '0', 22:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 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)) 22:41:45 INFO - Cleaning up... 22:41:45 INFO - Return code: 0 22:41:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:41: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')]} 22:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:45 INFO - 'HOME': '/Users/cltbld', 22:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:45 INFO - 'LOGNAME': 'cltbld', 22:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:45 INFO - 'MOZ_NO_REMOTE': '1', 22:41:45 INFO - 'NO_EM_RESTART': '1', 22:41:45 INFO - 'PAGER': '/bin/cat', 22:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:45 INFO - 'PWD': '/builds/slave/test', 22:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:45 INFO - 'SHELL': '/bin/bash', 22:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:45 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:45 INFO - 'USER': 'cltbld', 22:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:45 INFO - 'XPC_FLAGS': '0x0', 22:41:45 INFO - 'XPC_SERVICE_NAME': '0', 22:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:45 INFO - Downloading/unpacking jsonschema 22:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:41:48 INFO - Downloading/unpacking functools32 (from jsonschema) 22:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:41:48 INFO - warning: no files found matching '*.txt' 22:41:48 INFO - no previously-included directories found matching 'build' 22:41:48 INFO - no previously-included directories found matching 'dist' 22:41:48 INFO - no previously-included directories found matching '.git*' 22:41:48 INFO - Installing collected packages: jsonschema, functools32 22:41:48 INFO - Running setup.py install for functools32 22:41:48 INFO - warning: no files found matching '*.txt' 22:41:48 INFO - no previously-included directories found matching 'build' 22:41:48 INFO - no previously-included directories found matching 'dist' 22:41:48 INFO - no previously-included directories found matching '.git*' 22:41:48 INFO - Successfully installed jsonschema functools32 22:41:48 INFO - Cleaning up... 22:41:48 INFO - Return code: 0 22:41:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102769a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027704c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc8d6a170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, '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.VNsWVspbr0/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.DOlwk9DlGm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 22:41:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:41:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:41:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:41:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:41:48 INFO - 'HOME': '/Users/cltbld', 22:41:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:41:48 INFO - 'LOGNAME': 'cltbld', 22:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:48 INFO - 'MOZ_NO_REMOTE': '1', 22:41:48 INFO - 'NO_EM_RESTART': '1', 22:41:48 INFO - 'PAGER': '/bin/cat', 22:41:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:48 INFO - 'PWD': '/builds/slave/test', 22:41:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:41:48 INFO - 'SHELL': '/bin/bash', 22:41:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:41:48 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:41:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:41:48 INFO - 'USER': 'cltbld', 22:41:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:41:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:48 INFO - 'XPC_FLAGS': '0x0', 22:41:48 INFO - 'XPC_SERVICE_NAME': '0', 22:41:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:49 INFO - Downloading/unpacking flake8 22:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:41:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:41:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:41:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:41:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:41:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:41:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:41:52 INFO - no previously-included directories found matching 'docs/_build' 22:41:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:41:53 INFO - Running setup.py install for pep8 22:41:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:41:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:41:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:41:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:41:53 INFO - no previously-included directories found matching 'docs/_build' 22:41:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:41:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:41:53 INFO - Cleaning up... 22:41:53 INFO - Return code: 0 22:41:53 INFO - Running post-action listener: _resource_record_post_action 22:41:53 INFO - Running post-action listener: _start_resource_monitoring 22:41:53 INFO - Starting resource monitoring. 22:41:53 INFO - ##### 22:41:53 INFO - ##### Running install step. 22:41:53 INFO - ##### 22:41:53 INFO - Running pre-action listener: _resource_record_pre_action 22:41:53 INFO - Running main action method: install 22:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:53 INFO - Reading from file tmpfile_stdout 22:41:53 INFO - Detecting whether we're running mozinstall >=1.0... 22:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:41:53 INFO - Reading from file tmpfile_stdout 22:41:53 INFO - Output received: 22:41:53 INFO - Usage: mozinstall [options] installer 22:41:53 INFO - Options: 22:41:53 INFO - -h, --help show this help message and exit 22:41:53 INFO - -d DEST, --destination=DEST 22:41:53 INFO - Directory to install application into. [default: 22:41:53 INFO - "/builds/slave/test"] 22:41:53 INFO - --app=APP Application being installed. [default: firefox] 22:41:53 INFO - mkdir: /builds/slave/test/build/application 22:41:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:42:16 INFO - Reading from file tmpfile_stdout 22:42:16 INFO - Output received: 22:42:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:42:16 INFO - Running post-action listener: _resource_record_post_action 22:42:16 INFO - ##### 22:42:16 INFO - ##### Running run-tests step. 22:42:16 INFO - ##### 22:42:16 INFO - Running pre-action listener: _resource_record_pre_action 22:42:16 INFO - Running main action method: run_tests 22:42:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:42:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:42:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:42:16 INFO - 2016-05-16 22:42:16.093 screenresolution[1654:9404] starting screenresolution argv=screenresolution get 22:42:16 INFO - 2016-05-16 22:42:16.095 screenresolution[1654:9404] Display 0: 1600x1200x32@60 22:42:16 INFO - 2016-05-16 22:42:16.100 screenresolution[1655:9407] starting screenresolution argv=screenresolution list 22:42:16 INFO - Available Modes on Display 0 22:42:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:42:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:42:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:42:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:42:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:42:16 INFO - Intel Iris: 22:42:16 INFO - Chipset Model: Intel Iris 22:42:16 INFO - Type: GPU 22:42:16 INFO - Bus: Built-In 22:42:16 INFO - VRAM (Dynamic, Max): 1536 MB 22:42:16 INFO - Vendor: Intel (0x8086) 22:42:16 INFO - Device ID: 0x0a2e 22:42:16 INFO - Revision ID: 0x0009 22:42:16 INFO - Displays: 22:42:16 INFO - Display: 22:42:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:42:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:42:16 INFO - Display Serial Number: 1600x1200 60 22:42:16 INFO - Main Display: Yes 22:42:16 INFO - Mirror: Off 22:42:16 INFO - Online: Yes 22:42:16 INFO - Rotation: Supported 22:42:16 INFO - Return code: 0 22:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:42:16 INFO - Python 2.7.3 22:42:16 INFO - Return code: 0 22:42:16 INFO - grabbing minidump binary from tooltool 22:42: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')]} 22:42:16 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 0x10260dd30>, '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 0x102471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102604b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:42:16 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 22:42:16 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 22:42:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:16 INFO - Return code: 0 22:42:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:42:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:42:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:42:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:42:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:42:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:42:17 INFO - Return code: 0 22:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 22:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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 22:42:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VNsWVspbr0/Render', 22:42:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:42:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:42:17 INFO - 'HOME': '/Users/cltbld', 22:42:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:42:17 INFO - 'LOGNAME': 'cltbld', 22:42:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:42:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:17 INFO - 'MOZ_NO_REMOTE': '1', 22:42:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:42:17 INFO - 'NO_EM_RESTART': '1', 22:42:17 INFO - 'PAGER': '/bin/cat', 22:42:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:17 INFO - 'PWD': '/builds/slave/test', 22:42:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:42:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:42:17 INFO - 'SHELL': '/bin/bash', 22:42:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DOlwk9DlGm/Listeners', 22:42:17 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 22:42:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:42:17 INFO - 'USER': 'cltbld', 22:42:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:42:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:17 INFO - 'XPC_FLAGS': '0x0', 22:42:17 INFO - 'XPC_SERVICE_NAME': '0', 22:42:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:42:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 22:42:17 INFO - mozversion application_buildid: 20160516203739 22:42:17 INFO - mozversion application_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 22:42:17 INFO - mozversion application_display_name: Firefox 22:42:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:17 INFO - mozversion application_name: Firefox 22:42:17 INFO - mozversion application_remotingname: firefox 22:42:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:42:17 INFO - mozversion application_vendor: Mozilla 22:42:17 INFO - mozversion application_version: 47.0 22:42:17 INFO - mozversion platform_buildid: 20160516203739 22:42:17 INFO - mozversion platform_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 22:42:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:42:17 INFO - mozversion platform_version: 47.0 22:42:17 INFO - using testdate: 1463463737 22:42:17 INFO - actual date: 1463463737 22:42:17 INFO - starting webserver on 'localhost:49270' 22:42:17 INFO - SUITE-START | Running 2 tests 22:42:17 INFO - TEST-START | dromaeo_css 22:42:17 INFO - operating with platform_type : mac_ 22:42:17 INFO - Initialising browser for dromaeo_css test... 22:42:18 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpaf86S9/profile http://localhost:49270/getInfo.html) 22:42:20 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 22:42:20 INFO - PROCESS | 1673 | colorDepth:24 22:42:20 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 22:42:20 INFO - PROCESS | 1673 | __metrics 22:42:20 INFO - PROCESS | 1673 | 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" 22:42:20 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:42:20 INFO - TEST-INFO | 1673: exit 0 22:42:20 INFO - Browser initialized. 22:42:20 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:20 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpaf86S9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:32 INFO - PROCESS | 1677 | RSS: Main: 156983296 22:42:32 INFO - PROCESS | 1677 | 22:43:23 INFO - PROCESS | 1677 | 1463463803596 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] 22:45:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 22:45:35 INFO - PROCESS | 1677 | RSS: Main: 349843456 22:45:35 INFO - PROCESS | 1677 | 22:48:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 22:48:38 INFO - PROCESS | 1677 | RSS: Main: 287526912 22:48:38 INFO - PROCESS | 1677 | 22:51:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 22:51:40 INFO - PROCESS | 1677 | RSS: Main: 295292928 22:51:40 INFO - PROCESS | 1677 | 22:54:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 22:54:43 INFO - PROCESS | 1677 | RSS: Main: 251760640 22:54:43 INFO - PROCESS | 1677 | 22:57:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 22:57:46 INFO - PROCESS | 1677 | RSS: Main: 255471616 22:57:46 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 23:00:49 INFO - PROCESS | 1677 | RSS: Main: 302800896 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | __start_tp_report 23:00:49 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 23:00:49 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 23:00:49 INFO - PROCESS | 1677 | |i|pagename|runs| 23:00:49 INFO - PROCESS | 1677 | |0;dojo.html;3146.9999999999986;3333.699967002969;3644.23471071075;3674.706023518119;3695.611960744122;5796.594238403313;5805.593608447411;5808.186853840466;5814.912776308359;5823.330317013545;5773.422657734224;5826.533877289818;5828.950788858004;5852.707364631773;5863.296404431463;4606.33208184813;4908.975455122737;5216.478352164791;5247.501487358695;5297.523222909937;5322.361316642008;5323.9467605324035;5328.094223981932;5334.333208348957;5351.411344752094;5271.736413179326;5282.630215884889;5304.814331498379;5336.59975501837;5345.893082138355;5327.893442131155;5354.812581559666;5370.248165256867;5375.139977603604;5387.595930305203;5098.4136824265315;5268.894622107537;5286.709230992294;5300.231466437345;5301.363836339664;5657.830265092054;5705.6291341063115;5712.8000519982015;5727.627704199213;5741.913871291934;6150.569460137792;6308.116863639094;6309.400606942333;6309.400606942333;6314.968425157845;6251.593646412968;6275.466585340251;6297.590656607352;6300.117983482271;6301.243850737895;5942.227510423617;6015.428534289235;6037.274732261794;6059.030555111161;6085.300190478063;6356.2054743157105;6366.9681651591445;6375.776847810304;6381.840453988594;6398.360163983564;6127.356627554132;6143.911070236141;6205.627662340274;6266.968665156645;6298.653574053471;6274.309825919146;6303.92833218354;6316.557840951089;6322.272938612026;6325.96837015812;6263.96868015657;6314.989601663712;6315.463185629181;6317;6322.114903913456;5196.740162991835;6152.077188421683;6219.47134493564;6255.280642726054;6264.21697287839;4911.45973942866;4970.8757281068265;4981.078500477423;4996.850094497171;5015.523525265094;3728.179800443898;4491.438570178728;4501.617362524222;4510.143072816154;4520.321951707205;5937;6055.455009049118;6057.909131363033;6058.0004299291;6097.573169878155;6256.092866534327;6297.2128483939505;6308.337624549448;6321.3678632137335;6333.873322533524;5959.344472108065;6049.697515124226;6050.515958723292;6058.697065146725;6099.4815440688035;5485.561155107582;5487.890242195133;5494.423085576037;5498.945010549924;5509.9255645149615;6294.15028971083;6376.872462550816;6388.872222555523;6449.419552240227;6475.125858009203;6261.0608408737235;6297.905531417124;6301.369863013662;6304.905426418699;6317.747290108344;6344.492440604648;6450.774222902363;6462.224533056064;6462.676866156768;6467.902981455376;6152.600080994721;6215.627062376272;6292.811215663537;6294.15028971083;6312.621242725451;6294.8111556653375;6295.276043255084;6307.936920630735;6323.7786677466065;6328.936710632835;6295.779647712308;6304.211973503312;6306.085617585332;6308.022256550242;6314.589551679126;5024.698518088926;6047.606905551125;6149.2620885494025;6187.071939208975;6207.906881396692;6001.519878409804;6008.158857760004;6027.578069535266;6029.427204415573;6038.154658347747;6150.292716337678;6262.060690896402;6264.968675156595;6265.655388953652;6276.215473065867;6028.186194863637;6144.078388241799;6175.166352542349;6178.505719542516;6190.350013248544 23:00:49 INFO - PROCESS | 1677 | |1;ext.html;480.50027970910253;595.5116804220538;600.5135839969628;650.9609423434594;671.9260881303056;32080.197995050105;39980.20039599206;40293.59706402939;40312.39531407031;40315;43749.562504374946;44095.33856992148;44120.55879441205;44172;44257.11485770291;9624.278179136558;9830.901690983106;9832.508374581279;9833.360831545926;9839.409635421862;9663.855042174373;9846.458444785534;9851;9855;9867.457289849055;9785.412875227508;9984.600615975389;9990.300678952477;9991.600335986552;9991.900080999207;9897.50512474377;9974.152197063258;9988.05113514215;9988.40069595823;9990.750231244205;9697.418154910658;9821.852672209923;9828.21374290055;9837.163841073518;9840.950795245977;42512.57487425148;42899.78550107229;42999;43024.78487607542;43086.70739877809;2895.4498645257336;3653.0319465341704;3872.3029854626157;3899.7325869092374;3970.2059588082498;29115;30315.545266821016;30335;30801.845990770125;30918.690813091805;2763.322985868455;2777.402858385457;2805.9719402805913;2841.602175695404;2858.299716569433;393877;396916;397519;397684.0231597676;399066;47190;68517;68768;68873.65563172151;69107.3089269111;38761;46506.302405463946;46538.88072312043;46625;46630;17058.317667293417;17407;17415.564610884576;17417.954922704677;17432.477025689248;13938.651533711536;14020.719585608434;14025.579232623038;14031.859681403259;14044.157350558999;15238.847611523743;15288.694226115414;15425.922870385577;15462.922685386726;15595.908286420068;6477.352264773485;6624.8012559623285;6663.566868153554;6666.899996500057;6676.666166691646;978.848278516831;1086.8261078227445;1118.5637601335486;1135.28477059452;1197.3474456421272;25203.24390268295;30186.69813301883;30627.08118756441;30855.0743477696;31414.842925785226;1145.788029214598;1150.269578817457;1152.590830255264;1182.3260741377333;1251.9248845069326;12473.75052498945;15232.310600985498;15703.764443533357;15847;15999.440019599491;565156;572306.138469305;573145;574021;575764;62816.371836281054;63416.68291658605;63620.68189659022;63634;63945.04082438767;1470.6176394137387;1564.2022568490152;1581.5650696058676;1589.054512565022;1603.174365201922;30606.846965765028;30847.074587762403;31075;31353.68646313599;31470.37059258848;50530;51617;51635;51661.483385165666;51743.741281293354;427816;437687;438513;438713;439879;28725.712742872303;30730.692693073677;30929.69070309358;35345.469817953264;36017.63982360143;45001.09997800091;45745.54254457413;46460.30309545292;46496.53503464922;46629;37220.44169337516;37791.43312850255;37828.24343513059;38125.85622431331;38829.41755873607;37002.62997369992;37191.07022324355;37442.812785935894;38024.80987595044;38040.61959380481;36900;37467;37738;38389;39804.004899877735;33050.504242435905;34480.37956014683;34958;34985.82507087448;35021.64978350286;25968.961241550125;26001.479970400866;26120.216393508224;26327.341816453976;26900.05849795248 23:00:49 INFO - PROCESS | 1677 | |2;jquery.html;375.4368447329006;375.6337570868404;377.36790875283907;380.1484674329501;385.97491163074415;17509.387171449;20324.69512957307;21897.671534926987;22767;22780.088796448163;12287.201331913442;12552.874471255285;12628.621141365751;12634.305113218768;12647.494100236003;4245.554216807237;6150.600210986294;6153.692315384213;6156.230471191101;6157.384261573851;5872.354041055481;6024.246969128859;6118.388161183868;6135.846603834895;6157.476614487774;5461.836144915639;5529.391766905637;5540.279763630742;5545.944540554583;5559;5495.697736624484;5519;5523.944760552383;5528.695921724324;5529.170624406311;5341.599380046512;5588.636738611977;5592.804251851166;5605.271314729059;5611.270534830487;14120.293985300797;16746.916265418717;26786.464270714478;26965.325866853487;27071.187864363903;2120.6606942889216;2230.3309007297744;2333.3116730564525;2715.171872578863;2798.8460634665084;9974.750631234205;10062.849057264148;10242.53908574116;12088.274703517816;15334.693306133926;1728.3086765293983;1823.1431227323137;1842.484104450756;1852.9166187521594;1861.0415635947497;107916.38125428125;113934.43032784783;114594;114817;115852;11273.887261127447;11657.825132623017;11667.241629294069;11695.941520292514;11842.052635789116;14610;14626;14670.266486675624;14671.77992330116;14675.972681912164;9070.319726020443;9081.182693557479;9095.49974751395;9114.997350291462;9178.403403778733;7738.922610773933;9102.590383432762;9308.115729005734;9389.436633801994;9391.530423478798;4577.313402989512;4600.493945665974;4607.262837945979;4619.884502887455;4657.720536767804;1895.5166432559608;1907.3419670213755;1930.2472035906007;1935.6419062473487;1953.951151221231;901.4726385064679;967.2697113679127;993.7764003099245;1034.5551412892528;1047.4814966591587;20054.59890802176;20330.593388132154;20348.491287717927;20441.977901105183;20540.383788486368;862.4997501449144;974.8683927669815;980.7450062983532;1036.5905467340508;1087.027110735887;7820.804479887935;11034.393108379116;11060.612878549213;11069.225154239126;11098.55605775776;685843;687491;689749;690086;711614;71653;116051;120224.19663705051;120853.39573302078;124103;1056.366180291834;1073.5866691323897;1102.5589764094427;1102.5755084292446;1108.14672702019;18143.909280453514;18424.170912309248;18779.530511737317;19734.21063157515;19779.208831646574;51126.48873511217;51516;52670.73664631652;54290.09984650518;55972;52922.73538632282;71362.64318678374;74606.62696686698;74701;75183.24816751762;7907.723229686933;8070.5964701763505;8078.757637270891;8232.094469608459;8270.83458330818;9622.575165534936;10829.566817327219;13335.933320333335;13740.969427292794;13766.24285664258;11316.490757916079;11411;11839.82240266414;11943.940280298542;12003.939980300043;9656.468894210604;11538.307701537935;11640.792144385307;11653.6503904883;11998.40007999579;11772.411379431165;12101.636950891487;12137.453814578541;12283.815742763687;12296.139270250997;8329.458585191944;8437.873431898404;8462.323014158976;8572.699955501528;8594.527300998505;11705.473253703774;11941.701457463632;12152.696182595506;12191.75616487683;12211.572594959489 23:00:49 INFO - PROCESS | 1677 | |3;mootools.html;1529.6023034011155;1652.0583267537504;1678.60552770099;2033.095272603691;2112.190786254281;8323.37574681899;8949.015608283093;9112.90887091129;9120.543972801366;9137;7737.806554836132;8847.469151850893;8982.595783189756;9054.094590540943;9056.864147037799;2107.3677896631025;2575.742425757428;2578.9355266118405;2583.74162583742;2583.806214533908;2498.038255271724;2589.443269697015;2594.2865711929276;2594.299539124445;2603.8047146463996;2572.807039472047;2592.909248176314;2601.453694724101;2601.544729672309;2605.4137818990766;2558.2325302409204;2580.187241019082;2582.289870285677;2597.2727636261875;2597.3376788918895;2551.5152121097117;2588.6246494258417;2592.688877334713;2598.1815728045794;2604.6093086037245;9205.171534561921;9234.122758338015;9238.214751746109;9265.72202833916;9267.490288034156;5566.415526369713;5721.199032135504;5731.971340143273;5733.856653583652;5738.42615738427;3673.5591728992426;3777.0934975605933;3824.063104539378;3828.674562662177;3852.7303088783797;1034.8240799064176;1039.4127318065343;1040.9375437473775;1054.6150655010865;1073.2862646340175;12489.75020499585;12491.562795302212;12506.49974001039;12506.562270320586;12519.43662535188;4963.429205641398;5004.774785134678;5048.646594738407;5080.669756465818;5081.618878584121;10441.947790261;10467.94766026165;10478.476076196159;10485.37087774736;10546.57813687444;5009.12340340439;5647.830565083054;5724;5736.397678243808;5771.8557036074435;4655.883602909955;4789.928151077736;5010.624203184776;5166.974165129151;5221.242919776687;3781.6785573226584;3859.9421008684894;4006.3790112532606;4093.85671501496;4158.106007208465;1356.3692882809344;1367.6307397002952;1375.1061809823696;1379.5723325769043;1380.2270728392132;1204.114975493012;1204.9518019279305;1208;1459.160982435104;1464;7776.261255180862;8420.208500400904;8431.494110353398;8524.104968978292;8601.655933762579;1235.4687484381623;1288.3043156695467;1297.2087026913575;1300.336828217616;1310.758602789222;6492.577982431127;6494.870102597922;6585.209774827052;6588.637624930579;6589.637569933604;11079.335239885633;11443.485043173077;11555.36445495489;11644.708882278012;11649.708757281136;11044.502997365138;11242.49408776607;11249.43752812356;11254.549818007352;11427.028702560208;8658.95670521656;8759.036505984337;8791.648334066693;8801.647934082564;8804.339674524435;8138.552379619177;8168.305694015838;8207.097219305992;8293.585320733819;8300.086990430927;9943.502824858873;10041.397516149054;10134.746631334276;10143.137833284254;10190.133838623504;9987.901330853745;10409.791804163722;10441.425721585385;10461.163106951577;10647.30792498485;5878.588498805214;6420.486361091008;6595.571287866273;6786.287439818748;7438.516496427715;8543.487390756574;8568.271696905833;8612.526311052952;8629.09394513567;8641.049484556568;7422.517536360119;7516.699332026657;7535.886961695469;7659.4255430841795;7662.578558179131;7454;7460.179380268275;7486.251374862471;7554.773356799305;7584.051993500812;7863.410244231591;7888.211178882296;7891.289783919475;7901.17037711055;7908.881366779618;7108.46686498525;7154.2488038757265;7186.640667966685;7197.856042879009;7213.747518836815;7259.9274007259255;7309.4152467803515;7317.817054573678;7349.669264882986;7362 23:00:49 INFO - PROCESS | 1677 | |4;prototype.html;337.5645417411539;341.0705826622454;347.8712876235793;348.6583148514456;352.56458274031564;5173.430922598511;6511.706973186207;6554.213494380675;6566.540342176049;6571.44142747867;5614.11927004453;6074.967255566553;6480.773172938948;6485.708143133558;6488.513361497883;4653.23221668426;4757.119932812441;4762.809487620491;4857.854264372075;4919.532644398776;3865.342891708416;4856.882916929108;4885.706857588539;4888.828890988816;4890.608751299887;4849.5877850382585;4851.3450684157715;4851.369321988154;4860.198067318888;4870.391201099863;3800.3159431302215;4132.648724858391;4633.467151277612;4848.369711937461;4872.634552408584;4206.074663574009;4214.157168566299;4219.578042195786;4230.555791641864;4231.809568569422;5078.593712503028;5396.757145928404;6287.52843536732;6294.048844858063;6296.590721603081;5784.30588329399;5785.247917770705;5802.62282951611;5810.302763668345;5811.215485909391;5644.604877658566;6926.549774264707;6955.617441040741;6960.860782784316;6964.79105626832;4417.226985277595;4567.474740404863;4568;4568.817247310104;4573.428321459817;7198.244184360619;7361.337479626859;7363.153237377663;7363.300486453725;7370.041894553728;4679.9532004680195;4680.368150299734;4684.81260749573;4691.108689349013;4693.48371679115;4081.2449696805593;4617.515160908057;4739.3601863748645;4744.572988431058;4745.786439610226;4634.490206077328;5598.872428477152;5621.241132447068;5631.436856314418;5642.492175704124;6685.398314151653;6929.133858267716;6938.5836849789175;6944.895826562605;6996.090508233897;1615.7414813629762;1634.4524584264168;1646.8270831562513;1649.1012398242985;1651.0176445015197;993.6820217530321;1010.8584798128268;1042.4214560918763;1046.8482070099792;1068.5191663751343;6652.800415987528;6786.287439818847;6791.864162716718;6803.897941530881;6810.353016463428;7239.538556890682;7266.890996635055;7267.672954717051;7269.709211631582;7278.344948954619;6753.223379311442;6754.121964144728;6756.358145976124;6759.121314229119;6768.187817461838;3703.9074023149637;3799.35410980134;3837.827297771607;3843.8462461501226;3849.826757795906;5902.789928064736;6152.507799376129;7606.581638009962;7632.885506717293;7637.541747495168;7441.1070671519765;7472.626368681545;7474.1404738454685;7475.9252407476315;7492.7752167435065;6100.542459315569;7613.086429628369;7617.923820761722;7618;7618.733344333033;5538.556915446835;7240.855182896418;7246.818829529304;7257.564546127249;7263.055802745609;7073.3987611053635;7077.6461176941975;7080.468964827762;7094.609796461038;7111.288871112847;6686.398224159849;6914;7541.283578060075;7558.13081495635;7566.810829729301;4670.696404733681;4671.602913752369;4673.228917228756;4680.695754775928;4684.859454216379;7175.138983322035;7184.856302873809;7187.425005999403;7188.843346995775;7189.640517974185;6283.497320214463;6434.967825160844;6659.334066593302;6973;6993.720251189896;5981.581289309706;6872.553284036521;6966.094407726963;6973.267806880204;6974.232834388315;6799.184097908283;6809.5573787705625;6818.079559259635;6818.727250909908;6836.453083753188;6721.428678562377;6970;6971.9651401744695;6973.058637084132;6981.162260528769;6572.277049524453;6692.732290708512;6724.394804467622;6844.4182244509775;6911.723531058701 23:00:49 INFO - PROCESS | 1677 | |5;yui.html;597.9491743201828;713.1121753416996;752.1500704204249;781.9296263336298;798.4410912361345;15165.620859478504;15313.310901009454;15370.462033828804;15374.538763837074;15375.154366509838;14170.433182672681;14209.78685319721;14216.786748198785;14268.571942841705;14301.141931484119;805.8025783683006;815.282551354807;902.309733054214;955.7945041816008;1002.2382988928395;967.337373898878;972.8735264415616;981.1611072532988;982.5136557404095;983.8179936711731;1033.689893032091;1043.4626167523732;1044.4986406524872;1045.0124632222553;1046.6964580271713;860.8579584368603;1009.5860697114184;1050.6165249683886;1054.225144518778;1055.2244100586101;772.97681069568;776.4797585617649;777.7200207925142;777.9922200777976;780.7969927818751;15293.61765955849;15337.156456394894;15351.232438378036;15354.232288385536;15385.153816540085;11940.925316721537;12474.300193650815;12813.295268760214;13188.86811131886;13493.190408575518;10274.280800343979;10290.073893349634;10321.174306055498;10633.46832658364;11037.448127593669;3591.4253719405033;3595.49663047171;3636.945445818315;3677.7609455385314;3844.942325865114;79976.60011699963;80341.59829200876;81426.18573814245;82451.17548824495;82680;9686.903130968742;9895.901040989642;10012.54943527543;10169.898301016896;10192.796144077225;23202.76797232006;23230.883845580665;23234;23283;23286;7551.773446796605;7667.654955527015;7763.573003484749;7765.417593680384;7798.415118866108;4159.750414975111;4204.66362690984;4215.325547912319;4330;4347.7826108694435;3681.650243226889;3747.8500859965297;3750.0812300985885;3756.13608869956;3757.342465068602;518.4271380124983;593.1843714892024;616.0389791924612;663.7345061975152;675.9155105611799;552.1855263486326;559.672591533949;615.0727604246915;619.6777675608658;628.1990462160691;7834.200198473063;8309.127541608164;8419.200175983271;8475.872861907077;8497.787555311043;518.3054706692974;590.380100894068;601.3084952304885;618.8638499530097;622.7322251431838;3823.120682243044;3916.412538119248;3920.2159568085926;3946.1910308386714;4164.5210800757695;69549.30450695529;90405.54797225972;90445.54777226072;95800.52099739456;96113;60971;80774.59612702017;81069.59465202637;81090.59454702689;81942;71303.64348178226;72159.63920180366;72180;73064.63467682734;73304.53390932258;7821.1396746359;7837.529748215125;7918.604069796603;7965.645840207063;7974.322182614543;46596.53403465922;51757.96484070373;52329.738351308;52380;52986.145484907844;65904;72353.44230606426;72554;72990;73315.26684733084;10180.541875615467;10266.127379172854;10464.686059418229;10582.523786429783;10727.463626818471;9765.902340976783;10117.898821011695;10132.949335253277;10167.542460589144;10211.948940255252;10212.234082443698;10283.485825708834;10695.930406959242;10829.729256768644;10983.176261780238;10402.219833512365;10448.320859144435;10461.215408844215;10700.357978521313;10724.195685323475;10288.2798204125;10404.427756473164;10533.683989480327;10546.841797372892;10622;8633.30933525304;9050.124454116023;9071.727848164566;9294.907050929403;9390.67132650354;8057.919420805717;8831;8934.374593778373;9010.50442225684;9149.313801464783 23:00:49 INFO - PROCESS | 1677 | __end_tp_report 23:00:49 INFO - PROCESS | 1677 | __start_cc_report 23:00:49 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1839 23:00:49 INFO - PROCESS | 1677 | __end_cc_report 23:00:49 INFO - PROCESS | 1677 | __startTimestamp1463464849539__endTimestamp 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | ------- Summary: start ------- 23:00:49 INFO - PROCESS | 1677 | Number of tests: 6 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5833.53 Median:6097.57 stddev:661.23 (10.8%) stddev-sans-first:628.77 23:00:49 INFO - PROCESS | 1677 | Values: 3147.0 3333.7 3644.2 3674.7 3695.6 5796.6 5805.6 5808.2 5814.9 5823.3 5773.4 5826.5 5829.0 5852.7 5863.3 4606.3 4909.0 5216.5 5247.5 5297.5 5322.4 5323.9 5328.1 5334.3 5351.4 5271.7 5282.6 5304.8 5336.6 5345.9 5327.9 5354.8 5370.2 5375.1 5387.6 5098.4 5268.9 5286.7 5300.2 5301.4 5657.8 5705.6 5712.8 5727.6 5741.9 6150.6 6308.1 6309.4 6309.4 6315.0 6251.6 6275.5 6297.6 6300.1 6301.2 5942.2 6015.4 6037.3 6059.0 6085.3 6356.2 6367.0 6375.8 6381.8 6398.4 6127.4 6143.9 6205.6 6267.0 6298.7 6274.3 6303.9 6316.6 6322.3 6326.0 6264.0 6315.0 6315.5 6317.0 6322.1 5196.7 6152.1 6219.5 6255.3 6264.2 4911.5 4970.9 4981.1 4996.9 5015.5 3728.2 4491.4 4501.6 4510.1 4520.3 5937.0 6055.5 6057.9 6058.0 6097.6 6256.1 6297.2 6308.3 6321.4 6333.9 5959.3 6049.7 6050.5 6058.7 6099.5 5485.6 5487.9 5494.4 5498.9 5509.9 6294.2 6376.9 6388.9 6449.4 6475.1 6261.1 6297.9 6301.4 6304.9 6317.7 6344.5 6450.8 6462.2 6462.7 6467.9 6152.6 6215.6 6292.8 6294.2 6312.6 6294.8 6295.3 6307.9 6323.8 6328.9 6295.8 6304.2 6306.1 6308.0 6314.6 5024.7 6047.6 6149.3 6187.1 6207.9 6001.5 6008.2 6027.6 6029.4 6038.2 6150.3 6262.1 6265.0 6265.7 6276.2 6028.2 6144.1 6175.2 6178.5 6190.4 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:61890.46 Median:200443.10 stddev:126121.91 (62.9%) stddev-sans-first:126391.44 23:00:49 INFO - PROCESS | 1677 | Values: 480.5 595.5 600.5 651.0 671.9 32080.2 39980.2 40293.6 40312.4 40315.0 43749.6 44095.3 44120.6 44172.0 44257.1 9624.3 9830.9 9832.5 9833.4 9839.4 9663.9 9846.5 9851.0 9855.0 9867.5 9785.4 9984.6 9990.3 9991.6 9991.9 9897.5 9974.2 9988.1 9988.4 9990.8 9697.4 9821.9 9828.2 9837.2 9841.0 42512.6 42899.8 42999.0 43024.8 43086.7 2895.4 3653.0 3872.3 3899.7 3970.2 29115.0 30315.5 30335.0 30801.8 30918.7 2763.3 2777.4 2806.0 2841.6 2858.3 393877.0 396916.0 397519.0 397684.0 399066.0 47190.0 68517.0 68768.0 68873.7 69107.3 38761.0 46506.3 46538.9 46625.0 46630.0 17058.3 17407.0 17415.6 17418.0 17432.5 13938.7 14020.7 14025.6 14031.9 14044.2 15238.8 15288.7 15425.9 15462.9 15595.9 6477.4 6624.8 6663.6 6666.9 6676.7 978.8 1086.8 1118.6 1135.3 1197.3 25203.2 30186.7 30627.1 30855.1 31414.8 1145.8 1150.3 1152.6 1182.3 1251.9 12473.8 15232.3 15703.8 15847.0 15999.4 565156.0 572306.1 573145.0 574021.0 575764.0 62816.4 63416.7 63620.7 63634.0 63945.0 1470.6 1564.2 1581.6 1589.1 1603.2 30606.8 30847.1 31075.0 31353.7 31470.4 50530.0 51617.0 51635.0 51661.5 51743.7 427816.0 437687.0 438513.0 438713.0 439879.0 28725.7 30730.7 30929.7 35345.5 36017.6 45001.1 45745.5 46460.3 46496.5 46629.0 37220.4 37791.4 37828.2 38125.9 38829.4 37002.6 37191.1 37442.8 38024.8 38040.6 36900.0 37467.0 37738.0 38389.0 39804.0 33050.5 34480.4 34958.0 34985.8 35021.6 25969.0 26001.5 26120.2 26327.3 26900.1 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:36669.38 Median:12498.67 stddev:114438.11 (915.6%) stddev-sans-first:114726.69 23:00:49 INFO - PROCESS | 1677 | Values: 375.4 375.6 377.4 380.1 386.0 17509.4 20324.7 21897.7 22767.0 22780.1 12287.2 12552.9 12628.6 12634.3 12647.5 4245.6 6150.6 6153.7 6156.2 6157.4 5872.4 6024.2 6118.4 6135.8 6157.5 5461.8 5529.4 5540.3 5545.9 5559.0 5495.7 5519.0 5523.9 5528.7 5529.2 5341.6 5588.6 5592.8 5605.3 5611.3 14120.3 16746.9 26786.5 26965.3 27071.2 2120.7 2230.3 2333.3 2715.2 2798.8 9974.8 10062.8 10242.5 12088.3 15334.7 1728.3 1823.1 1842.5 1852.9 1861.0 107916.4 113934.4 114594.0 114817.0 115852.0 11273.9 11657.8 11667.2 11695.9 11842.1 14610.0 14626.0 14670.3 14671.8 14676.0 9070.3 9081.2 9095.5 9115.0 9178.4 7738.9 9102.6 9308.1 9389.4 9391.5 4577.3 4600.5 4607.3 4619.9 4657.7 1895.5 1907.3 1930.2 1935.6 1954.0 901.5 967.3 993.8 1034.6 1047.5 20054.6 20330.6 20348.5 20442.0 20540.4 862.5 974.9 980.7 1036.6 1087.0 7820.8 11034.4 11060.6 11069.2 11098.6 685843.0 687491.0 689749.0 690086.0 711614.0 71653.0 116051.0 120224.2 120853.4 124103.0 1056.4 1073.6 1102.6 1102.6 1108.1 18143.9 18424.2 18779.5 19734.2 19779.2 51126.5 51516.0 52670.7 54290.1 55972.0 52922.7 71362.6 74606.6 74701.0 75183.2 7907.7 8070.6 8078.8 8232.1 8270.8 9622.6 10829.6 13335.9 13741.0 13766.2 11316.5 11411.0 11839.8 11943.9 12003.9 9656.5 11538.3 11640.8 11653.7 11998.4 11772.4 12101.6 12137.5 12283.8 12296.1 8329.5 8437.9 8462.3 8572.7 8594.5 11705.5 11941.7 12152.7 12191.8 12211.6 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6287.35 Median:4984.10 stddev:3323.82 (66.7%) stddev-sans-first:3313.91 23:00:49 INFO - PROCESS | 1677 | Values: 1529.6 1652.1 1678.6 2033.1 2112.2 8323.4 8949.0 9112.9 9120.5 9137.0 7737.8 8847.5 8982.6 9054.1 9056.9 2107.4 2575.7 2578.9 2583.7 2583.8 2498.0 2589.4 2594.3 2594.3 2603.8 2572.8 2592.9 2601.5 2601.5 2605.4 2558.2 2580.2 2582.3 2597.3 2597.3 2551.5 2588.6 2592.7 2598.2 2604.6 9205.2 9234.1 9238.2 9265.7 9267.5 5566.4 5721.2 5732.0 5733.9 5738.4 3673.6 3777.1 3824.1 3828.7 3852.7 1034.8 1039.4 1040.9 1054.6 1073.3 12489.8 12491.6 12506.5 12506.6 12519.4 4963.4 5004.8 5048.6 5080.7 5081.6 10441.9 10467.9 10478.5 10485.4 10546.6 5009.1 5647.8 5724.0 5736.4 5771.9 4655.9 4789.9 5010.6 5167.0 5221.2 3781.7 3859.9 4006.4 4093.9 4158.1 1356.4 1367.6 1375.1 1379.6 1380.2 1204.1 1205.0 1208.0 1459.2 1464.0 7776.3 8420.2 8431.5 8524.1 8601.7 1235.5 1288.3 1297.2 1300.3 1310.8 6492.6 6494.9 6585.2 6588.6 6589.6 11079.3 11443.5 11555.4 11644.7 11649.7 11044.5 11242.5 11249.4 11254.5 11427.0 8659.0 8759.0 8791.6 8801.6 8804.3 8138.6 8168.3 8207.1 8293.6 8300.1 9943.5 10041.4 10134.7 10143.1 10190.1 9987.9 10409.8 10441.4 10461.2 10647.3 5878.6 6420.5 6595.6 6786.3 7438.5 8543.5 8568.3 8612.5 8629.1 8641.0 7422.5 7516.7 7535.9 7659.4 7662.6 7454.0 7460.2 7486.3 7554.8 7584.1 7863.4 7888.2 7891.3 7901.2 7908.9 7108.5 7154.2 7186.6 7197.9 7213.7 7259.9 7309.4 7317.8 7349.7 7362.0 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5659.53 Median:6483.24 stddev:1805.44 (27.8%) stddev-sans-first:1765.77 23:00:49 INFO - PROCESS | 1677 | Values: 337.6 341.1 347.9 348.7 352.6 5173.4 6511.7 6554.2 6566.5 6571.4 5614.1 6075.0 6480.8 6485.7 6488.5 4653.2 4757.1 4762.8 4857.9 4919.5 3865.3 4856.9 4885.7 4888.8 4890.6 4849.6 4851.3 4851.4 4860.2 4870.4 3800.3 4132.6 4633.5 4848.4 4872.6 4206.1 4214.2 4219.6 4230.6 4231.8 5078.6 5396.8 6287.5 6294.0 6296.6 5784.3 5785.2 5802.6 5810.3 5811.2 5644.6 6926.5 6955.6 6960.9 6964.8 4417.2 4567.5 4568.0 4568.8 4573.4 7198.2 7361.3 7363.2 7363.3 7370.0 4680.0 4680.4 4684.8 4691.1 4693.5 4081.2 4617.5 4739.4 4744.6 4745.8 4634.5 5598.9 5621.2 5631.4 5642.5 6685.4 6929.1 6938.6 6944.9 6996.1 1615.7 1634.5 1646.8 1649.1 1651.0 993.7 1010.9 1042.4 1046.8 1068.5 6652.8 6786.3 6791.9 6803.9 6810.4 7239.5 7266.9 7267.7 7269.7 7278.3 6753.2 6754.1 6756.4 6759.1 6768.2 3703.9 3799.4 3837.8 3843.8 3849.8 5902.8 6152.5 7606.6 7632.9 7637.5 7441.1 7472.6 7474.1 7475.9 7492.8 6100.5 7613.1 7617.9 7618.0 7618.7 5538.6 7240.9 7246.8 7257.6 7263.1 7073.4 7077.6 7080.5 7094.6 7111.3 6686.4 6914.0 7541.3 7558.1 7566.8 4670.7 4671.6 4673.2 4680.7 4684.9 7175.1 7184.9 7187.4 7188.8 7189.6 6283.5 6435.0 6659.3 6973.0 6993.7 5981.6 6872.6 6966.1 6973.3 6974.2 6799.2 6809.6 6818.1 6818.7 6836.5 6721.4 6970.0 6972.0 6973.1 6981.2 6572.3 6692.7 6724.4 6844.4 6911.7 23:00:49 INFO - PROCESS | 1677 | 23:00:49 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18340.82 Median:26424.08 stddev:25883.80 (98.0%) stddev-sans-first:25922.12 23:00:49 INFO - PROCESS | 1677 | Values: 597.9 713.1 752.2 781.9 798.4 15165.6 15313.3 15370.5 15374.5 15375.2 14170.4 14209.8 14216.8 14268.6 14301.1 805.8 815.3 902.3 955.8 1002.2 967.3 972.9 981.2 982.5 983.8 1033.7 1043.5 1044.5 1045.0 1046.7 860.9 1009.6 1050.6 1054.2 1055.2 773.0 776.5 777.7 778.0 780.8 15293.6 15337.2 15351.2 15354.2 15385.2 11940.9 12474.3 12813.3 13188.9 13493.2 10274.3 10290.1 10321.2 10633.5 11037.4 3591.4 3595.5 3636.9 3677.8 3844.9 79976.6 80341.6 81426.2 82451.2 82680.0 9686.9 9895.9 10012.5 10169.9 10192.8 23202.8 23230.9 23234.0 23283.0 23286.0 7551.8 7667.7 7763.6 7765.4 7798.4 4159.8 4204.7 4215.3 4330.0 4347.8 3681.7 3747.9 3750.1 3756.1 3757.3 518.4 593.2 616.0 663.7 675.9 552.2 559.7 615.1 619.7 628.2 7834.2 8309.1 8419.2 8475.9 8497.8 518.3 590.4 601.3 618.9 622.7 3823.1 3916.4 3920.2 3946.2 4164.5 69549.3 90405.5 90445.5 95800.5 96113.0 60971.0 80774.6 81069.6 81090.6 81942.0 71303.6 72159.6 72180.0 73064.6 73304.5 7821.1 7837.5 7918.6 7965.6 7974.3 46596.5 51758.0 52329.7 52380.0 52986.1 65904.0 72353.4 72554.0 72990.0 73315.3 10180.5 10266.1 10464.7 10582.5 10727.5 9765.9 10117.9 10132.9 10167.5 10211.9 10212.2 10283.5 10695.9 10829.7 10983.2 10402.2 10448.3 10461.2 10700.4 10724.2 10288.3 10404.4 10533.7 10546.8 10622.0 8633.3 9050.1 9071.7 9294.9 9390.7 8057.9 8831.0 8934.4 9010.5 9149.3 23:00:49 INFO - PROCESS | 1677 | -------- Summary: end -------- 23:00:49 INFO - PROCESS | 1677 | 23:00:50 INFO - TEST-INFO | 1677: exit 0 23:00:50 INFO - TEST-OK | dromaeo_css | took 1112242ms 23:00:50 INFO - TEST-START | kraken 23:00:50 INFO - operating with platform_type : mac_ 23:00:50 INFO - Initialising browser for kraken test... 23:00:50 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpcAoyqj/profile http://localhost:49270/getInfo.html) 23:00:52 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 23:00:52 INFO - PROCESS | 1682 | colorDepth:24 23:00:52 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 23:00:52 INFO - PROCESS | 1682 | __metrics 23:00:52 INFO - PROCESS | 1682 | 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" 23:00:52 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:00:52 INFO - TEST-INFO | 1682: exit 0 23:00:52 INFO - Browser initialized. 23:00:52 INFO - Running cycle 1/1 for kraken test... 23:00:52 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpcAoyqj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:04 INFO - PROCESS | 1685 | RSS: Main: 157122560 23:01:04 INFO - PROCESS | 1685 | 23:01:07 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:07 INFO - PROCESS | 1685 | RSS: Main: 213798912 23:01:07 INFO - PROCESS | 1685 | 23:01:10 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 23:01:10 INFO - PROCESS | 1685 | RSS: Main: 223809536 23:01:10 INFO - PROCESS | 1685 | 23:01:13 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 23:01:14 INFO - PROCESS | 1685 | RSS: Main: 214155264 23:01:14 INFO - PROCESS | 1685 | 23:01:16 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 23:01:17 INFO - PROCESS | 1685 | RSS: Main: 215207936 23:01:17 INFO - PROCESS | 1685 | 23:01:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:19 INFO - PROCESS | 1685 | RSS: Main: 214953984 23:01:19 INFO - PROCESS | 1685 | 23:01:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:23 INFO - PROCESS | 1685 | RSS: Main: 214802432 23:01:23 INFO - PROCESS | 1685 | 23:01:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:26 INFO - PROCESS | 1685 | RSS: Main: 216223744 23:01:26 INFO - PROCESS | 1685 | 23:01:29 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 23:01:29 INFO - PROCESS | 1685 | RSS: Main: 216539136 23:01:29 INFO - PROCESS | 1685 | 23:01:31 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:31 INFO - PROCESS | 1685 | RSS: Main: 250478592 23:01:31 INFO - PROCESS | 1685 | 23:01:33 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:34 INFO - PROCESS | 1685 | RSS: Main: 249831424 23:01:34 INFO - PROCESS | 1685 | 23:01:36 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:36 INFO - PROCESS | 1685 | RSS: Main: 255320064 23:01:36 INFO - PROCESS | 1685 | 23:01:39 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:01:39 INFO - PROCESS | 1685 | RSS: Main: 256704512 23:01:39 INFO - PROCESS | 1685 | 23:01:42 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:01:43 INFO - PROCESS | 1685 | RSS: Main: 256913408 23:01:43 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 23:01:44 INFO - PROCESS | 1685 | RSS: Main: 319205376 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | __start_tp_report 23:01:44 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 23:01:44 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 23:01:44 INFO - PROCESS | 1685 | |i|pagename|runs| 23:01:44 INFO - PROCESS | 1685 | |0;ai-astar;112;108;111;109;111;112;115;110;108;110 23:01:44 INFO - PROCESS | 1685 | |1;audio-beat-detection;155;117;149;148;117;136;120;150;150;120 23:01:44 INFO - PROCESS | 1685 | |2;audio-dft;183;186;184;185;186;186;188;181;182;182 23:01:44 INFO - PROCESS | 1685 | |3;audio-fft;76;102;109;156;55;58;57;58;113;56 23:01:44 INFO - PROCESS | 1685 | |4;audio-oscillator;88;96;162;114;118;82;120;75;79;122 23:01:44 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;87;84;88;85;86;83;88;85;87;84 23:01:44 INFO - PROCESS | 1685 | |6;imaging-darkroom;92;92;93;93;93;95;93;94;93;93 23:01:44 INFO - PROCESS | 1685 | |7;imaging-desaturate;84;84;85;85;82;85;85;85;84;99 23:01:44 INFO - PROCESS | 1685 | |8;json-parse-financial;55;59;59;57;59;57;58;60;53;51 23:01:44 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;63;62;69;77;70;68;66;65;65;67 23:01:44 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;81;80;77;80;80;80;80;79;81;84 23:01:44 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;133;129;131;111;116;120;127;126;118;117 23:01:44 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;155;169;135;133;135;127;148;134;133;131 23:01:44 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;66;66;64;66;66;63;67;65;64;66 23:01:44 INFO - PROCESS | 1685 | __end_tp_report 23:01:44 INFO - PROCESS | 1685 | __start_cc_report 23:01:44 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1156 23:01:44 INFO - PROCESS | 1685 | __end_cc_report 23:01:44 INFO - PROCESS | 1685 | __startTimestamp1463464904967__endTimestamp 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | ------- Summary: start ------- 23:01:44 INFO - PROCESS | 1685 | Number of tests: 14 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.12 (1.9%) stddev-sans-first:2.19 23:01:44 INFO - PROCESS | 1685 | Values: 112.0 108.0 111.0 109.0 111.0 112.0 115.0 110.0 108.0 110.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:148.50 stddev:15.98 (10.8%) stddev-sans-first:15.44 23:01:44 INFO - PROCESS | 1685 | Values: 155.0 117.0 149.0 148.0 117.0 136.0 120.0 150.0 150.0 120.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.26 (1.2%) stddev-sans-first:2.35 23:01:44 INFO - PROCESS | 1685 | Values: 183.0 186.0 184.0 185.0 186.0 186.0 188.0 181.0 182.0 182.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:84.00 Median:56.50 stddev:34.55 (61.2%) stddev-sans-first:36.53 23:01:44 INFO - PROCESS | 1685 | Values: 76.0 102.0 109.0 156.0 55.0 58.0 57.0 58.0 113.0 56.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:77.00 stddev:26.84 (34.9%) stddev-sans-first:27.70 23:01:44 INFO - PROCESS | 1685 | Values: 88.0 96.0 162.0 114.0 118.0 82.0 120.0 75.0 79.0 122.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.77 (2.0%) stddev-sans-first:1.81 23:01:44 INFO - PROCESS | 1685 | Values: 87.0 84.0 88.0 85.0 86.0 83.0 88.0 85.0 87.0 84.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 23:01:44 INFO - PROCESS | 1685 | Values: 92.0 92.0 93.0 93.0 93.0 95.0 93.0 94.0 93.0 93.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.00 stddev:4.73 (5.6%) stddev-sans-first:4.97 23:01:44 INFO - PROCESS | 1685 | Values: 84.0 84.0 85.0 85.0 82.0 85.0 85.0 85.0 84.0 99.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:58.50 stddev:2.94 (5.0%) stddev-sans-first:3.04 23:01:44 INFO - PROCESS | 1685 | Values: 55.0 59.0 59.0 57.0 59.0 57.0 58.0 60.0 53.0 51.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:4.26 (6.3%) stddev-sans-first:4.24 23:01:44 INFO - PROCESS | 1685 | Values: 63.0 62.0 69.0 77.0 70.0 68.0 66.0 65.0 65.0 67.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:1.75 (2.2%) stddev-sans-first:1.83 23:01:44 INFO - PROCESS | 1685 | Values: 81.0 80.0 77.0 80.0 80.0 80.0 80.0 79.0 81.0 84.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:126.50 stddev:7.36 (5.8%) stddev-sans-first:6.82 23:01:44 INFO - PROCESS | 1685 | Values: 133.0 129.0 131.0 111.0 116.0 120.0 127.0 126.0 118.0 117.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:135.00 stddev:13.18 (9.8%) stddev-sans-first:12.82 23:01:44 INFO - PROCESS | 1685 | Values: 155.0 169.0 135.0 133.0 135.0 127.0 148.0 134.0 133.0 131.0 23:01:44 INFO - PROCESS | 1685 | 23:01:44 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 23:01:44 INFO - PROCESS | 1685 | Values: 66.0 66.0 64.0 66.0 66.0 63.0 67.0 65.0 64.0 66.0 23:01:44 INFO - PROCESS | 1685 | -------- Summary: end -------- 23:01:44 INFO - PROCESS | 1685 | 23:01:45 INFO - TEST-INFO | 1685: exit 0 23:01:45 INFO - TEST-OK | kraken | took 55612ms 23:01:45 INFO - SUITE-END | took 1167s 23:01:46 INFO - Completed test suite (00:19:28) 23:01:46 INFO - javascript benchmark 23:01:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3146.9999999999986, 3333.699967002969, 3644.23471071075, 3674.706023518119, 3695.611960744122, 5796.594238403313, 5805.593608447411, 5808.186853840466, 5814.912776308359, 5823.330317013545, 5773.422657734224, 5826.533877289818, 5828.950788858004, 5852.707364631773, 5863.296404431463, 4606.33208184813, 4908.975455122737, 5216.478352164791, 5247.501487358695, 5297.523222909937, 5322.361316642008, 5323.9467605324035, 5328.094223981932, 5334.333208348957, 5351.411344752094, 5271.736413179326, 5282.630215884889, 5304.814331498379, 5336.59975501837, 5345.893082138355, 5327.893442131155, 5354.812581559666, 5370.248165256867, 5375.139977603604, 5387.595930305203, 5098.4136824265315, 5268.894622107537, 5286.709230992294, 5300.231466437345, 5301.363836339664, 5657.830265092054, 5705.6291341063115, 5712.8000519982015, 5727.627704199213, 5741.913871291934, 6150.569460137792, 6308.116863639094, 6309.400606942333, 6309.400606942333, 6314.968425157845, 6251.593646412968, 6275.466585340251, 6297.590656607352, 6300.117983482271, 6301.243850737895, 5942.227510423617, 6015.428534289235, 6037.274732261794, 6059.030555111161, 6085.300190478063, 6356.2054743157105, 6366.9681651591445, 6375.776847810304, 6381.840453988594, 6398.360163983564, 6127.356627554132, 6143.911070236141, 6205.627662340274, 6266.968665156645, 6298.653574053471, 6274.309825919146, 6303.92833218354, 6316.557840951089, 6322.272938612026, 6325.96837015812, 6263.96868015657, 6314.989601663712, 6315.463185629181, 6317.0, 6322.114903913456, 5196.740162991835, 6152.077188421683, 6219.47134493564, 6255.280642726054, 6264.21697287839, 4911.45973942866, 4970.8757281068265, 4981.078500477423, 4996.850094497171, 5015.523525265094, 3728.179800443898, 4491.438570178728, 4501.617362524222, 4510.143072816154, 4520.321951707205, 5937.0, 6055.455009049118, 6057.909131363033, 6058.0004299291, 6097.573169878155, 6256.092866534327, 6297.2128483939505, 6308.337624549448, 6321.3678632137335, 6333.873322533524, 5959.344472108065, 6049.697515124226, 6050.515958723292, 6058.697065146725, 6099.4815440688035, 5485.561155107582, 5487.890242195133, 5494.423085576037, 5498.945010549924, 5509.9255645149615, 6294.15028971083, 6376.872462550816, 6388.872222555523, 6449.419552240227, 6475.125858009203, 6261.0608408737235, 6297.905531417124, 6301.369863013662, 6304.905426418699, 6317.747290108344, 6344.492440604648, 6450.774222902363, 6462.224533056064, 6462.676866156768, 6467.902981455376, 6152.600080994721, 6215.627062376272, 6292.811215663537, 6294.15028971083, 6312.621242725451, 6294.8111556653375, 6295.276043255084, 6307.936920630735, 6323.7786677466065, 6328.936710632835, 6295.779647712308, 6304.211973503312, 6306.085617585332, 6308.022256550242, 6314.589551679126, 5024.698518088926, 6047.606905551125, 6149.2620885494025, 6187.071939208975, 6207.906881396692, 6001.519878409804, 6008.158857760004, 6027.578069535266, 6029.427204415573, 6038.154658347747, 6150.292716337678, 6262.060690896402, 6264.968675156595, 6265.655388953652, 6276.215473065867, 6028.186194863637, 6144.078388241799, 6175.166352542349, 6178.505719542516, 6190.350013248544], "unit": "score", "name": "dojo.html", "value": 5791.328445783143}, {"lowerIsBetter": false, "replicates": [480.50027970910253, 595.5116804220538, 600.5135839969628, 650.9609423434594, 671.9260881303056, 32080.197995050105, 39980.20039599206, 40293.59706402939, 40312.39531407031, 40315.0, 43749.562504374946, 44095.33856992148, 44120.55879441205, 44172.0, 44257.11485770291, 9624.278179136558, 9830.901690983106, 9832.508374581279, 9833.360831545926, 9839.409635421862, 9663.855042174373, 9846.458444785534, 9851.0, 9855.0, 9867.457289849055, 9785.412875227508, 9984.600615975389, 9990.300678952477, 9991.600335986552, 9991.900080999207, 9897.50512474377, 9974.152197063258, 9988.05113514215, 9988.40069595823, 9990.750231244205, 9697.418154910658, 9821.852672209923, 9828.21374290055, 9837.163841073518, 9840.950795245977, 42512.57487425148, 42899.78550107229, 42999.0, 43024.78487607542, 43086.70739877809, 2895.4498645257336, 3653.0319465341704, 3872.3029854626157, 3899.7325869092374, 3970.2059588082498, 29115.0, 30315.545266821016, 30335.0, 30801.845990770125, 30918.690813091805, 2763.322985868455, 2777.402858385457, 2805.9719402805913, 2841.602175695404, 2858.299716569433, 393877.0, 396916.0, 397519.0, 397684.0231597676, 399066.0, 47190.0, 68517.0, 68768.0, 68873.65563172151, 69107.3089269111, 38761.0, 46506.302405463946, 46538.88072312043, 46625.0, 46630.0, 17058.317667293417, 17407.0, 17415.564610884576, 17417.954922704677, 17432.477025689248, 13938.651533711536, 14020.719585608434, 14025.579232623038, 14031.859681403259, 14044.157350558999, 15238.847611523743, 15288.694226115414, 15425.922870385577, 15462.922685386726, 15595.908286420068, 6477.352264773485, 6624.8012559623285, 6663.566868153554, 6666.899996500057, 6676.666166691646, 978.848278516831, 1086.8261078227445, 1118.5637601335486, 1135.28477059452, 1197.3474456421272, 25203.24390268295, 30186.69813301883, 30627.08118756441, 30855.0743477696, 31414.842925785226, 1145.788029214598, 1150.269578817457, 1152.590830255264, 1182.3260741377333, 1251.9248845069326, 12473.75052498945, 15232.310600985498, 15703.764443533357, 15847.0, 15999.440019599491, 565156.0, 572306.138469305, 573145.0, 574021.0, 575764.0, 62816.371836281054, 63416.68291658605, 63620.68189659022, 63634.0, 63945.04082438767, 1470.6176394137387, 1564.2022568490152, 1581.5650696058676, 1589.054512565022, 1603.174365201922, 30606.846965765028, 30847.074587762403, 31075.0, 31353.68646313599, 31470.37059258848, 50530.0, 51617.0, 51635.0, 51661.483385165666, 51743.741281293354, 427816.0, 437687.0, 438513.0, 438713.0, 439879.0, 28725.712742872303, 30730.692693073677, 30929.69070309358, 35345.469817953264, 36017.63982360143, 45001.09997800091, 45745.54254457413, 46460.30309545292, 46496.53503464922, 46629.0, 37220.44169337516, 37791.43312850255, 37828.24343513059, 38125.85622431331, 38829.41755873607, 37002.62997369992, 37191.07022324355, 37442.812785935894, 38024.80987595044, 38040.61959380481, 36900.0, 37467.0, 37738.0, 38389.0, 39804.004899877735, 33050.504242435905, 34480.37956014683, 34958.0, 34985.82507087448, 35021.64978350286, 25968.961241550125, 26001.479970400866, 26120.216393508224, 26327.341816453976, 26900.05849795248], "unit": "score", "name": "ext.html", "value": 19937.52417013595}, {"lowerIsBetter": false, "replicates": [375.4368447329006, 375.6337570868404, 377.36790875283907, 380.1484674329501, 385.97491163074415, 17509.387171449, 20324.69512957307, 21897.671534926987, 22767.0, 22780.088796448163, 12287.201331913442, 12552.874471255285, 12628.621141365751, 12634.305113218768, 12647.494100236003, 4245.554216807237, 6150.600210986294, 6153.692315384213, 6156.230471191101, 6157.384261573851, 5872.354041055481, 6024.246969128859, 6118.388161183868, 6135.846603834895, 6157.476614487774, 5461.836144915639, 5529.391766905637, 5540.279763630742, 5545.944540554583, 5559.0, 5495.697736624484, 5519.0, 5523.944760552383, 5528.695921724324, 5529.170624406311, 5341.599380046512, 5588.636738611977, 5592.804251851166, 5605.271314729059, 5611.270534830487, 14120.293985300797, 16746.916265418717, 26786.464270714478, 26965.325866853487, 27071.187864363903, 2120.6606942889216, 2230.3309007297744, 2333.3116730564525, 2715.171872578863, 2798.8460634665084, 9974.750631234205, 10062.849057264148, 10242.53908574116, 12088.274703517816, 15334.693306133926, 1728.3086765293983, 1823.1431227323137, 1842.484104450756, 1852.9166187521594, 1861.0415635947497, 107916.38125428125, 113934.43032784783, 114594.0, 114817.0, 115852.0, 11273.887261127447, 11657.825132623017, 11667.241629294069, 11695.941520292514, 11842.052635789116, 14610.0, 14626.0, 14670.266486675624, 14671.77992330116, 14675.972681912164, 9070.319726020443, 9081.182693557479, 9095.49974751395, 9114.997350291462, 9178.403403778733, 7738.922610773933, 9102.590383432762, 9308.115729005734, 9389.436633801994, 9391.530423478798, 4577.313402989512, 4600.493945665974, 4607.262837945979, 4619.884502887455, 4657.720536767804, 1895.5166432559608, 1907.3419670213755, 1930.2472035906007, 1935.6419062473487, 1953.951151221231, 901.4726385064679, 967.2697113679127, 993.7764003099245, 1034.5551412892528, 1047.4814966591587, 20054.59890802176, 20330.593388132154, 20348.491287717927, 20441.977901105183, 20540.383788486368, 862.4997501449144, 974.8683927669815, 980.7450062983532, 1036.5905467340508, 1087.027110735887, 7820.804479887935, 11034.393108379116, 11060.612878549213, 11069.225154239126, 11098.55605775776, 685843.0, 687491.0, 689749.0, 690086.0, 711614.0, 71653.0, 116051.0, 120224.19663705051, 120853.39573302078, 124103.0, 1056.366180291834, 1073.5866691323897, 1102.5589764094427, 1102.5755084292446, 1108.14672702019, 18143.909280453514, 18424.170912309248, 18779.530511737317, 19734.21063157515, 19779.208831646574, 51126.48873511217, 51516.0, 52670.73664631652, 54290.09984650518, 55972.0, 52922.73538632282, 71362.64318678374, 74606.62696686698, 74701.0, 75183.24816751762, 7907.723229686933, 8070.5964701763505, 8078.757637270891, 8232.094469608459, 8270.83458330818, 9622.575165534936, 10829.566817327219, 13335.933320333335, 13740.969427292794, 13766.24285664258, 11316.490757916079, 11411.0, 11839.82240266414, 11943.940280298542, 12003.939980300043, 9656.468894210604, 11538.307701537935, 11640.792144385307, 11653.6503904883, 11998.40007999579, 11772.411379431165, 12101.636950891487, 12137.453814578541, 12283.815742763687, 12296.139270250997, 8329.458585191944, 8437.873431898404, 8462.323014158976, 8572.699955501528, 8594.527300998505, 11705.473253703774, 11941.701457463632, 12152.696182595506, 12191.75616487683, 12211.572594959489], "unit": "score", "name": "jquery.html", "value": 9548.51997303405}, {"lowerIsBetter": false, "replicates": [1529.6023034011155, 1652.0583267537504, 1678.60552770099, 2033.095272603691, 2112.190786254281, 8323.37574681899, 8949.015608283093, 9112.90887091129, 9120.543972801366, 9137.0, 7737.806554836132, 8847.469151850893, 8982.595783189756, 9054.094590540943, 9056.864147037799, 2107.3677896631025, 2575.742425757428, 2578.9355266118405, 2583.74162583742, 2583.806214533908, 2498.038255271724, 2589.443269697015, 2594.2865711929276, 2594.299539124445, 2603.8047146463996, 2572.807039472047, 2592.909248176314, 2601.453694724101, 2601.544729672309, 2605.4137818990766, 2558.2325302409204, 2580.187241019082, 2582.289870285677, 2597.2727636261875, 2597.3376788918895, 2551.5152121097117, 2588.6246494258417, 2592.688877334713, 2598.1815728045794, 2604.6093086037245, 9205.171534561921, 9234.122758338015, 9238.214751746109, 9265.72202833916, 9267.490288034156, 5566.415526369713, 5721.199032135504, 5731.971340143273, 5733.856653583652, 5738.42615738427, 3673.5591728992426, 3777.0934975605933, 3824.063104539378, 3828.674562662177, 3852.7303088783797, 1034.8240799064176, 1039.4127318065343, 1040.9375437473775, 1054.6150655010865, 1073.2862646340175, 12489.75020499585, 12491.562795302212, 12506.49974001039, 12506.562270320586, 12519.43662535188, 4963.429205641398, 5004.774785134678, 5048.646594738407, 5080.669756465818, 5081.618878584121, 10441.947790261, 10467.94766026165, 10478.476076196159, 10485.37087774736, 10546.57813687444, 5009.12340340439, 5647.830565083054, 5724.0, 5736.397678243808, 5771.8557036074435, 4655.883602909955, 4789.928151077736, 5010.624203184776, 5166.974165129151, 5221.242919776687, 3781.6785573226584, 3859.9421008684894, 4006.3790112532606, 4093.85671501496, 4158.106007208465, 1356.3692882809344, 1367.6307397002952, 1375.1061809823696, 1379.5723325769043, 1380.2270728392132, 1204.114975493012, 1204.9518019279305, 1208.0, 1459.160982435104, 1464.0, 7776.261255180862, 8420.208500400904, 8431.494110353398, 8524.104968978292, 8601.655933762579, 1235.4687484381623, 1288.3043156695467, 1297.2087026913575, 1300.336828217616, 1310.758602789222, 6492.577982431127, 6494.870102597922, 6585.209774827052, 6588.637624930579, 6589.637569933604, 11079.335239885633, 11443.485043173077, 11555.36445495489, 11644.708882278012, 11649.708757281136, 11044.502997365138, 11242.49408776607, 11249.43752812356, 11254.549818007352, 11427.028702560208, 8658.95670521656, 8759.036505984337, 8791.648334066693, 8801.647934082564, 8804.339674524435, 8138.552379619177, 8168.305694015838, 8207.097219305992, 8293.585320733819, 8300.086990430927, 9943.502824858873, 10041.397516149054, 10134.746631334276, 10143.137833284254, 10190.133838623504, 9987.901330853745, 10409.791804163722, 10441.425721585385, 10461.163106951577, 10647.30792498485, 5878.588498805214, 6420.486361091008, 6595.571287866273, 6786.287439818748, 7438.516496427715, 8543.487390756574, 8568.271696905833, 8612.526311052952, 8629.09394513567, 8641.049484556568, 7422.517536360119, 7516.699332026657, 7535.886961695469, 7659.4255430841795, 7662.578558179131, 7454.0, 7460.179380268275, 7486.251374862471, 7554.773356799305, 7584.051993500812, 7863.410244231591, 7888.211178882296, 7891.289783919475, 7901.17037711055, 7908.881366779618, 7108.46686498525, 7154.2488038757265, 7186.640667966685, 7197.856042879009, 7213.747518836815, 7259.9274007259255, 7309.4152467803515, 7317.817054573678, 7349.669264882986, 7362.0], "unit": "score", "name": "mootools.html", "value": 5139.813664473882}, {"lowerIsBetter": false, "replicates": [337.5645417411539, 341.0705826622454, 347.8712876235793, 348.6583148514456, 352.56458274031564, 5173.430922598511, 6511.706973186207, 6554.213494380675, 6566.540342176049, 6571.44142747867, 5614.11927004453, 6074.967255566553, 6480.773172938948, 6485.708143133558, 6488.513361497883, 4653.23221668426, 4757.119932812441, 4762.809487620491, 4857.854264372075, 4919.532644398776, 3865.342891708416, 4856.882916929108, 4885.706857588539, 4888.828890988816, 4890.608751299887, 4849.5877850382585, 4851.3450684157715, 4851.369321988154, 4860.198067318888, 4870.391201099863, 3800.3159431302215, 4132.648724858391, 4633.467151277612, 4848.369711937461, 4872.634552408584, 4206.074663574009, 4214.157168566299, 4219.578042195786, 4230.555791641864, 4231.809568569422, 5078.593712503028, 5396.757145928404, 6287.52843536732, 6294.048844858063, 6296.590721603081, 5784.30588329399, 5785.247917770705, 5802.62282951611, 5810.302763668345, 5811.215485909391, 5644.604877658566, 6926.549774264707, 6955.617441040741, 6960.860782784316, 6964.79105626832, 4417.226985277595, 4567.474740404863, 4568.0, 4568.817247310104, 4573.428321459817, 7198.244184360619, 7361.337479626859, 7363.153237377663, 7363.300486453725, 7370.041894553728, 4679.9532004680195, 4680.368150299734, 4684.81260749573, 4691.108689349013, 4693.48371679115, 4081.2449696805593, 4617.515160908057, 4739.3601863748645, 4744.572988431058, 4745.786439610226, 4634.490206077328, 5598.872428477152, 5621.241132447068, 5631.436856314418, 5642.492175704124, 6685.398314151653, 6929.133858267716, 6938.5836849789175, 6944.895826562605, 6996.090508233897, 1615.7414813629762, 1634.4524584264168, 1646.8270831562513, 1649.1012398242985, 1651.0176445015197, 993.6820217530321, 1010.8584798128268, 1042.4214560918763, 1046.8482070099792, 1068.5191663751343, 6652.800415987528, 6786.287439818847, 6791.864162716718, 6803.897941530881, 6810.353016463428, 7239.538556890682, 7266.890996635055, 7267.672954717051, 7269.709211631582, 7278.344948954619, 6753.223379311442, 6754.121964144728, 6756.358145976124, 6759.121314229119, 6768.187817461838, 3703.9074023149637, 3799.35410980134, 3837.827297771607, 3843.8462461501226, 3849.826757795906, 5902.789928064736, 6152.507799376129, 7606.581638009962, 7632.885506717293, 7637.541747495168, 7441.1070671519765, 7472.626368681545, 7474.1404738454685, 7475.9252407476315, 7492.7752167435065, 6100.542459315569, 7613.086429628369, 7617.923820761722, 7618.0, 7618.733344333033, 5538.556915446835, 7240.855182896418, 7246.818829529304, 7257.564546127249, 7263.055802745609, 7073.3987611053635, 7077.6461176941975, 7080.468964827762, 7094.609796461038, 7111.288871112847, 6686.398224159849, 6914.0, 7541.283578060075, 7558.13081495635, 7566.810829729301, 4670.696404733681, 4671.602913752369, 4673.228917228756, 4680.695754775928, 4684.859454216379, 7175.138983322035, 7184.856302873809, 7187.425005999403, 7188.843346995775, 7189.640517974185, 6283.497320214463, 6434.967825160844, 6659.334066593302, 6973.0, 6993.720251189896, 5981.581289309706, 6872.553284036521, 6966.094407726963, 6973.267806880204, 6974.232834388315, 6799.184097908283, 6809.5573787705625, 6818.079559259635, 6818.727250909908, 6836.453083753188, 6721.428678562377, 6970.0, 6971.9651401744695, 6973.058637084132, 6981.162260528769, 6572.277049524453, 6692.732290708512, 6724.394804467622, 6844.4182244509775, 6911.723531058701], "unit": "score", "name": "prototype.html", "value": 5067.980381306377}, {"lowerIsBetter": false, "replicates": [597.9491743201828, 713.1121753416996, 752.1500704204249, 781.9296263336298, 798.4410912361345, 15165.620859478504, 15313.310901009454, 15370.462033828804, 15374.538763837074, 15375.154366509838, 14170.433182672681, 14209.78685319721, 14216.786748198785, 14268.571942841705, 14301.141931484119, 805.8025783683006, 815.282551354807, 902.309733054214, 955.7945041816008, 1002.2382988928395, 967.337373898878, 972.8735264415616, 981.1611072532988, 982.5136557404095, 983.8179936711731, 1033.689893032091, 1043.4626167523732, 1044.4986406524872, 1045.0124632222553, 1046.6964580271713, 860.8579584368603, 1009.5860697114184, 1050.6165249683886, 1054.225144518778, 1055.2244100586101, 772.97681069568, 776.4797585617649, 777.7200207925142, 777.9922200777976, 780.7969927818751, 15293.61765955849, 15337.156456394894, 15351.232438378036, 15354.232288385536, 15385.153816540085, 11940.925316721537, 12474.300193650815, 12813.295268760214, 13188.86811131886, 13493.190408575518, 10274.280800343979, 10290.073893349634, 10321.174306055498, 10633.46832658364, 11037.448127593669, 3591.4253719405033, 3595.49663047171, 3636.945445818315, 3677.7609455385314, 3844.942325865114, 79976.60011699963, 80341.59829200876, 81426.18573814245, 82451.17548824495, 82680.0, 9686.903130968742, 9895.901040989642, 10012.54943527543, 10169.898301016896, 10192.796144077225, 23202.76797232006, 23230.883845580665, 23234.0, 23283.0, 23286.0, 7551.773446796605, 7667.654955527015, 7763.573003484749, 7765.417593680384, 7798.415118866108, 4159.750414975111, 4204.66362690984, 4215.325547912319, 4330.0, 4347.7826108694435, 3681.650243226889, 3747.8500859965297, 3750.0812300985885, 3756.13608869956, 3757.342465068602, 518.4271380124983, 593.1843714892024, 616.0389791924612, 663.7345061975152, 675.9155105611799, 552.1855263486326, 559.672591533949, 615.0727604246915, 619.6777675608658, 628.1990462160691, 7834.200198473063, 8309.127541608164, 8419.200175983271, 8475.872861907077, 8497.787555311043, 518.3054706692974, 590.380100894068, 601.3084952304885, 618.8638499530097, 622.7322251431838, 3823.120682243044, 3916.412538119248, 3920.2159568085926, 3946.1910308386714, 4164.5210800757695, 69549.30450695529, 90405.54797225972, 90445.54777226072, 95800.52099739456, 96113.0, 60971.0, 80774.59612702017, 81069.59465202637, 81090.59454702689, 81942.0, 71303.64348178226, 72159.63920180366, 72180.0, 73064.63467682734, 73304.53390932258, 7821.1396746359, 7837.529748215125, 7918.604069796603, 7965.645840207063, 7974.322182614543, 46596.53403465922, 51757.96484070373, 52329.738351308, 52380.0, 52986.145484907844, 65904.0, 72353.44230606426, 72554.0, 72990.0, 73315.26684733084, 10180.541875615467, 10266.127379172854, 10464.686059418229, 10582.523786429783, 10727.463626818471, 9765.902340976783, 10117.898821011695, 10132.949335253277, 10167.542460589144, 10211.948940255252, 10212.234082443698, 10283.485825708834, 10695.930406959242, 10829.729256768644, 10983.176261780238, 10402.219833512365, 10448.320859144435, 10461.215408844215, 10700.357978521313, 10724.195685323475, 10288.2798204125, 10404.427756473164, 10533.683989480327, 10546.841797372892, 10622.0, 8633.30933525304, 9050.124454116023, 9071.727848164566, 9294.907050929403, 9390.67132650354, 8057.919420805717, 8831.0, 8934.374593778373, 9010.50442225684, 9149.313801464783], "unit": "score", "name": "yui.html", "value": 6945.509397209117}], "name": "dromaeo_css", "value": 7643.946874893098}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 109.0, 111.0, 112.0, 115.0, 110.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [155.0, 117.0, 149.0, 148.0, 117.0, 136.0, 120.0, 150.0, 150.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 136.2}, {"lowerIsBetter": true, "replicates": [183.0, 186.0, 184.0, 185.0, 186.0, 186.0, 188.0, 181.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [76.0, 102.0, 109.0, 156.0, 55.0, 58.0, 57.0, 58.0, 113.0, 56.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [88.0, 96.0, 162.0, 114.0, 118.0, 82.0, 120.0, 75.0, 79.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 88.0, 85.0, 86.0, 83.0, 88.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 93.0, 95.0, 93.0, 94.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 85.0, 82.0, 85.0, 85.0, 85.0, 84.0, 99.0], "unit": "score", "name": "imaging-desaturate", "value": 85.8}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 59.0, 57.0, 59.0, 57.0, 58.0, 60.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 69.0, 77.0, 70.0, 68.0, 66.0, 65.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 77.0, 80.0, 80.0, 80.0, 80.0, 79.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [133.0, 129.0, 131.0, 111.0, 116.0, 120.0, 127.0, 126.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [155.0, 169.0, 135.0, 133.0, 135.0, 127.0, 148.0, 134.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 64.0, 66.0, 66.0, 63.0, 67.0, 65.0, 64.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1417.6}]} 23:01:46 INFO - Return code: 0 23:01:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:01:46 INFO - # TBPL SUCCESS # 23:01:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:01:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:01:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:01:46 INFO - 2016-05-16 23:01:46.280 screenresolution[1689:11511] starting screenresolution argv=screenresolution get 23:01:46 INFO - 2016-05-16 23:01:46.283 screenresolution[1689:11511] Display 0: 1600x1200x32@60 23:01:46 INFO - 2016-05-16 23:01:46.289 screenresolution[1690:11514] starting screenresolution argv=screenresolution list 23:01:46 INFO - Available Modes on Display 0 23:01:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:01:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:01:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:01:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:01:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:01:46 INFO - Intel Iris: 23:01:46 INFO - Chipset Model: Intel Iris 23:01:46 INFO - Type: GPU 23:01:46 INFO - Bus: Built-In 23:01:46 INFO - VRAM (Dynamic, Max): 1536 MB 23:01:46 INFO - Vendor: Intel (0x8086) 23:01:46 INFO - Device ID: 0x0a2e 23:01:46 INFO - Revision ID: 0x0009 23:01:46 INFO - Displays: 23:01:46 INFO - Display: 23:01:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:01:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:01:46 INFO - Display Serial Number: 1600x1200 60 23:01:46 INFO - Main Display: Yes 23:01:46 INFO - Mirror: Off 23:01:46 INFO - Online: Yes 23:01:46 INFO - Rotation: Supported 23:01:46 INFO - Return code: 0 23:01:46 INFO - Running post-action listener: _resource_record_post_action 23:01:46 INFO - Running post-run listener: _resource_record_post_run 23:01:47 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 32583168; Write bytes: 508968960; Read time: 320; Write time: 1587 23:01:47 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 197511680; Write bytes: 197167104; Read time: 17855; Write time: 370 23:01:47 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 31661568; Write bytes: 301844480; Read time: 306; Write time: 1189 23:01:47 INFO - Running post-run listener: _upload_blobber_files 23:01:47 INFO - Blob upload gear active. 23:01:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:01:47 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 23:01:47 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:01:47 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:01:48 INFO - (blobuploader) - INFO - Open directory for files ... 23:01:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:01:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:01:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:01:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:48 INFO - (blobuploader) - INFO - Done attempting. 23:01:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:01:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:01:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:01:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:01:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:01:49 INFO - (blobuploader) - INFO - Done attempting. 23:01:49 INFO - (blobuploader) - INFO - Iteration through files over. 23:01:49 INFO - Return code: 0 23:01:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:01:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:01:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a884fb1c45b196fa22e361327cee731d5a2549b36ba9d09eb9ed5a35f4452df13e1bb3c3a3e05c9282c72ef279baf42a658c2a318009d403ab52ea23c710aafd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48452ecfe1ee259e57b0d6ef1077f439d35ce1d75b502876107c986f9d19115fb5baaee8786a32a3e1a1c477199d8e33ad2b040f7719525471e6039cfd68a234"} 23:01:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:01:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:01:49 INFO - Contents: 23:01:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a884fb1c45b196fa22e361327cee731d5a2549b36ba9d09eb9ed5a35f4452df13e1bb3c3a3e05c9282c72ef279baf42a658c2a318009d403ab52ea23c710aafd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48452ecfe1ee259e57b0d6ef1077f439d35ce1d75b502876107c986f9d19115fb5baaee8786a32a3e1a1c477199d8e33ad2b040f7719525471e6039cfd68a234"} 23:01:49 INFO - Running post-run listener: copy_logs_to_upload_dir 23:01:49 INFO - Copying logs to upload dir... 23:01:49 INFO - mkdir: /builds/slave/test/build/upload/logs 23:01:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.895738 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-05-16 23:01:49.981966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:01:49.985366) ========= 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.VNsWVspbr0/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.DOlwk9DlGm/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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/Mozilla-Beta/sha512/a884fb1c45b196fa22e361327cee731d5a2549b36ba9d09eb9ed5a35f4452df13e1bb3c3a3e05c9282c72ef279baf42a658c2a318009d403ab52ea23c710aafd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48452ecfe1ee259e57b0d6ef1077f439d35ce1d75b502876107c986f9d19115fb5baaee8786a32a3e1a1c477199d8e33ad2b040f7719525471e6039cfd68a234"} build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a884fb1c45b196fa22e361327cee731d5a2549b36ba9d09eb9ed5a35f4452df13e1bb3c3a3e05c9282c72ef279baf42a658c2a318009d403ab52ea23c710aafd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48452ecfe1ee259e57b0d6ef1077f439d35ce1d75b502876107c986f9d19115fb5baaee8786a32a3e1a1c477199d8e33ad2b040f7719525471e6039cfd68a234"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:01:50.019220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:01:50.019546) ========= 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.VNsWVspbr0/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.DOlwk9DlGm/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005331 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:01:50.067412) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:01:50.067716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:01:50.071104) ========= ========= Total master_lag: 0.22 =========