builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0090 starttime: 1462489555.46 results: success (0) buildid: 20160505142107 builduid: 5ff692bcf09146beadbd427f348b434b revision: daa53f98b541117b380d848f34eb00570ae71d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.456678) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.457090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.457375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.478238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.478546) ========= 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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-05 16:05:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-05-05 16:05:55 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192684 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.687662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.687970) ========= 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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.019910 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:55.738591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 16:05:55.738895) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev daa53f98b541117b380d848f34eb00570ae71d2b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev daa53f98b541117b380d848f34eb00570ae71d2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.58Jaz1nvkp/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.cVgnwduzmQ/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-05 16:05:55,830 truncating revision to first 12 chars 2016-05-05 16:05:55,830 Setting DEBUG logging. 2016-05-05 16:05:55,830 attempt 1/10 2016-05-05 16:05:55,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/daa53f98b541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 16:05:57,046 unpacking tar archive at: fx-team-daa53f98b541/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462066 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 16:05:57.224395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:57.224758) ========= script_repo_revision: daa53f98b541117b380d848f34eb00570ae71d2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:57.225170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:57.225451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 16:05:57.240731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-05-05 16:05:57.241101) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.58Jaz1nvkp/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.cVgnwduzmQ/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:05:57 INFO - MultiFileLogger online at 20160505 16:05:57 in /builds/slave/test 16:05:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:05:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:57 INFO - {'append_to_log': False, 16:05:57 INFO - 'base_work_dir': '/builds/slave/test', 16:05:57 INFO - 'blob_upload_branch': 'Fx-Team', 16:05:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:57 INFO - 'branch': 'Fx-Team', 16:05:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:57 INFO - 'config_files': ('talos/mac_config.py',), 16:05:57 INFO - 'default_actions': ('clobber', 16:05:57 INFO - 'read-buildbot-config', 16:05:57 INFO - 'download-and-extract', 16:05:57 INFO - 'populate-webroot', 16:05:57 INFO - 'create-virtualenv', 16:05:57 INFO - 'install', 16:05:57 INFO - 'run-tests'), 16:05:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:57 INFO - 'download_minidump_stackwalk': True, 16:05:57 INFO - 'download_symbols': 'ondemand', 16:05:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:05:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:05:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:05:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:05:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:57 INFO - 'installer_path': 'installer.exe', 16:05:57 INFO - 'log_level': 'info', 16:05:57 INFO - 'log_name': 'talos', 16:05:57 INFO - 'log_to_console': True, 16:05:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:05:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:05:57 INFO - 'opt_config_files': (), 16:05:57 INFO - 'pip_index': False, 16:05:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:05:57 INFO - 'cmd': ('bash', 16:05:57 INFO - '-c', 16:05:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:05:57 INFO - 'enabled': True, 16:05:57 INFO - 'halt_on_failure': False, 16:05:57 INFO - 'name': 'check_screen_resolution'},), 16:05:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:05:57 INFO - 'cmd': ('bash', 16:05:57 INFO - '-c', 16:05:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:05:57 INFO - 'enabled': True, 16:05:57 INFO - 'halt_on_failure': False, 16:05:57 INFO - 'name': 'check_screen_resolution'},), 16:05:57 INFO - 'run_cmd_checks_enabled': True, 16:05:57 INFO - 'sps_profile': False, 16:05:57 INFO - 'sps_profile_interval': 0, 16:05:57 INFO - 'suite': 'dromaeojs', 16:05:57 INFO - 'system_bits': '32', 16:05:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:57 INFO - 'title': 't-yosemite-r7-0090', 16:05:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:57 INFO - 'use_talos_json': True, 16:05:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:57 INFO - 'work_dir': 'build'} 16:05:57 INFO - ##### 16:05:57 INFO - ##### Running clobber step. 16:05:57 INFO - ##### 16:05:57 INFO - Running pre-action listener: _resource_record_pre_action 16:05:57 INFO - Running main action method: clobber 16:05:57 INFO - rmtree: /builds/slave/test/build 16:05:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:58 INFO - Running post-action listener: _resource_record_post_action 16:05:58 INFO - ##### 16:05:58 INFO - ##### Running read-buildbot-config step. 16:05:58 INFO - ##### 16:05:58 INFO - Running pre-action listener: _resource_record_pre_action 16:05:58 INFO - Running main action method: read_buildbot_config 16:05:58 INFO - Using buildbot properties: 16:05:58 INFO - { 16:05:58 INFO - "project": "", 16:05:58 INFO - "product": "firefox", 16:05:58 INFO - "script_repo_revision": "production", 16:05:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:05:58 INFO - "repository": "", 16:05:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:05:58 INFO - "buildid": "20160505142107", 16:05:58 INFO - "pgo_build": "False", 16:05:58 INFO - "basedir": "/builds/slave/test", 16:05:58 INFO - "buildnumber": 809, 16:05:58 INFO - "slavename": "t-yosemite-r7-0090", 16:05:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:05:58 INFO - "platform": "yosemite_r7", 16:05:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:05:58 INFO - "branch": "fx-team", 16:05:58 INFO - "repo_path": "integration/fx-team", 16:05:58 INFO - "revision": "daa53f98b541117b380d848f34eb00570ae71d2b", 16:05:58 INFO - "stage_platform": "macosx64", 16:05:58 INFO - "builduid": "5ff692bcf09146beadbd427f348b434b", 16:05:58 INFO - "slavebuilddir": "test" 16:05:58 INFO - } 16:05:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 16:05:58 INFO - Running post-action listener: _resource_record_post_action 16:05:58 INFO - ##### 16:05:58 INFO - ##### Running download-and-extract step. 16:05:58 INFO - ##### 16:05:58 INFO - Running pre-action listener: _resource_record_pre_action 16:05:58 INFO - Running main action method: download_and_extract 16:05:58 INFO - mkdir: /builds/slave/test/build/tests 16:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:58 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:05:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 16:05:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 16:05:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 16:06:11 INFO - Downloaded 1199 bytes. 16:06:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:06:11 INFO - Using the following test package requirements: 16:06:11 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:06:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 16:06:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 16:06:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'jsshell-mac.zip'], 16:06:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 16:06:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:06:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 16:06:11 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 16:06:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 16:06:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:06:11 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 16:06:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:06:11 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:06:13 INFO - Downloaded 18144951 bytes. 16:06:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:06:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:06:16 INFO - Return code: 0 16:06:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:06: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')]} 16:06:16 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:06:17 INFO - Downloaded 18144951 bytes. 16:06:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:06:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:06:21 INFO - Return code: 0 16:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:06:21 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:06:22 INFO - Downloaded 10840152 bytes. 16:06:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:06:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:06:22 INFO - Return code: 0 16:06: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')]} 16:06:22 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:06:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:06:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:06:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 16:06:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 16:06:26 INFO - Downloaded 110400026 bytes. 16:06:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:06:26 INFO - mkdir: /builds/slave/test/properties 16:06:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:06:26 INFO - Writing to file /builds/slave/test/properties/build_url 16:06:26 INFO - Contents: 16:06:26 INFO - build_url:https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:06:27 INFO - Running post-action listener: _resource_record_post_action 16:06:27 INFO - Running post-action listener: set_extra_try_arguments 16:06:27 INFO - ##### 16:06:27 INFO - ##### Running populate-webroot step. 16:06:27 INFO - ##### 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: populate_webroot 16:06:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:06:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:06:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:06:27 INFO - '--tppagecycles', 16:06:27 INFO - '7'], 16:06:27 INFO - 'tests': ['tsvgm']}}, 16:06:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:06:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:06:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:06:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:06:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['damp', 'tps']}, 16:06:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'tests': ['damp', 'tps']}, 16:06:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['dromaeo_dom']}, 16:06:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:06:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint']}, 16:06:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint']}, 16:06:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint']}, 16:06:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint']}, 16:06:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint']}, 16:06:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint']}, 16:06:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['tsvgx', 16:06:27 INFO - 'tsvgr_opacity', 16:06:27 INFO - 'tart', 16:06:27 INFO - 'tscrollx', 16:06:27 INFO - 'cart']}, 16:06:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:06:27 INFO - 'tsvgr_opacity', 16:06:27 INFO - 'tart', 16:06:27 INFO - 'tscrollx', 16:06:27 INFO - 'cart']}, 16:06:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-e10s'], 16:06:27 INFO - 'tests': ['tp5o']}, 16:06:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'tests': ['tp5o']}, 16:06:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-e10s', 16:06:27 INFO - '--xperf_path', 16:06:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:27 INFO - 'tests': ['tp5n']}, 16:06:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:27 INFO - 'talos_options': ['--xperf_path', 16:06:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:27 INFO - 'tests': ['tp5n']}}, 16:06:27 INFO - 'talos.zip': {'path': '', 16:06:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:06:27 INFO - Running post-action listener: _resource_record_post_action 16:06:27 INFO - ##### 16:06:27 INFO - ##### Running create-virtualenv step. 16:06:27 INFO - ##### 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: create_virtualenv 16:06:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:06:27 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 16:06:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:06:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:06:27 INFO - Using real prefix '/tools/python27' 16:06:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:06:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:06:31 INFO - Installing pip.................done. 16:06:31 INFO - Return code: 0 16:06:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:31 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:31 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 16:06:31 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 16:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:31 INFO - 'HOME': '/Users/cltbld', 16:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:31 INFO - 'LOGNAME': 'cltbld', 16:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:31 INFO - 'MOZ_NO_REMOTE': '1', 16:06:31 INFO - 'NO_EM_RESTART': '1', 16:06:31 INFO - 'PAGER': '/bin/cat', 16:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:31 INFO - 'PWD': '/builds/slave/test', 16:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:31 INFO - 'SHELL': '/bin/bash', 16:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:31 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:31 INFO - 'USER': 'cltbld', 16:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:31 INFO - 'XPC_FLAGS': '0x0', 16:06:31 INFO - 'XPC_SERVICE_NAME': '0', 16:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:31 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 16:06:31 INFO - Cleaning up... 16:06:31 INFO - Return code: 0 16:06:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:31 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:31 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 16:06:31 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 16:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:31 INFO - 'HOME': '/Users/cltbld', 16:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:31 INFO - 'LOGNAME': 'cltbld', 16:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:31 INFO - 'MOZ_NO_REMOTE': '1', 16:06:31 INFO - 'NO_EM_RESTART': '1', 16:06:31 INFO - 'PAGER': '/bin/cat', 16:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:31 INFO - 'PWD': '/builds/slave/test', 16:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:31 INFO - 'SHELL': '/bin/bash', 16:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:31 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:31 INFO - 'USER': 'cltbld', 16:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:31 INFO - 'XPC_FLAGS': '0x0', 16:06:31 INFO - 'XPC_SERVICE_NAME': '0', 16:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:31 INFO - Downloading/unpacking psutil>=0.7.1 16:06:31 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 16:06:31 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 16:06:31 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 16:06:31 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 16:06:31 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 16:06:31 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 16:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:06:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:35 INFO - Installing collected packages: psutil 16:06:35 INFO - Running setup.py install for psutil 16:06:35 INFO - building 'psutil._psutil_osx' extension 16:06:35 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 16:06:35 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 16:06:35 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 16:06:35 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 16:06:35 INFO - building 'psutil._psutil_posix' extension 16:06:35 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 16:06:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:06:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:06:35 INFO - ^ 16:06:35 INFO - 1 warning generated. 16:06:35 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 16:06:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:35 INFO - Successfully installed psutil 16:06:35 INFO - Cleaning up... 16:06:35 INFO - Return code: 0 16:06:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:35 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:35 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 16:06:35 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 16:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:35 INFO - 'HOME': '/Users/cltbld', 16:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:35 INFO - 'LOGNAME': 'cltbld', 16:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:35 INFO - 'MOZ_NO_REMOTE': '1', 16:06:35 INFO - 'NO_EM_RESTART': '1', 16:06:35 INFO - 'PAGER': '/bin/cat', 16:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:35 INFO - 'PWD': '/builds/slave/test', 16:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:35 INFO - 'SHELL': '/bin/bash', 16:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:35 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:35 INFO - 'USER': 'cltbld', 16:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:35 INFO - 'XPC_FLAGS': '0x0', 16:06:35 INFO - 'XPC_SERVICE_NAME': '0', 16:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:06:36 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 16:06:36 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 16:06:36 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 16:06:36 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 16:06:36 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 16:06:36 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 16:06:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:06:38 INFO - Installing collected packages: mozsystemmonitor 16:06:38 INFO - Running setup.py install for mozsystemmonitor 16:06:38 INFO - Successfully installed mozsystemmonitor 16:06:38 INFO - Cleaning up... 16:06:38 INFO - Return code: 0 16:06:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:38 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:38 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 16:06:38 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 16:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:38 INFO - 'HOME': '/Users/cltbld', 16:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:38 INFO - 'LOGNAME': 'cltbld', 16:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:38 INFO - 'MOZ_NO_REMOTE': '1', 16:06:38 INFO - 'NO_EM_RESTART': '1', 16:06:38 INFO - 'PAGER': '/bin/cat', 16:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:38 INFO - 'PWD': '/builds/slave/test', 16:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:38 INFO - 'SHELL': '/bin/bash', 16:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:38 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:38 INFO - 'USER': 'cltbld', 16:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:38 INFO - 'XPC_FLAGS': '0x0', 16:06:38 INFO - 'XPC_SERVICE_NAME': '0', 16:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:06:39 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 16:06:39 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 16:06:39 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 16:06:39 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 16:06:39 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 16:06:39 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 16:06:41 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:42 INFO - Downloading docopt-0.6.1.tar.gz 16:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:42 INFO - Running setup.py install for blobuploader 16:06:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:43 INFO - Running setup.py install for requests 16:06:43 INFO - Running setup.py install for docopt 16:06:43 INFO - Successfully installed blobuploader requests docopt 16:06:43 INFO - Cleaning up... 16:06:43 INFO - Return code: 0 16:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:43 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')]} 16:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:43 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')]} 16:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:43 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:43 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 16:06:43 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 16:06:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:43 INFO - 'HOME': '/Users/cltbld', 16:06:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:43 INFO - 'LOGNAME': 'cltbld', 16:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:43 INFO - 'MOZ_NO_REMOTE': '1', 16:06:43 INFO - 'NO_EM_RESTART': '1', 16:06:43 INFO - 'PAGER': '/bin/cat', 16:06:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:43 INFO - 'PWD': '/builds/slave/test', 16:06:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:43 INFO - 'SHELL': '/bin/bash', 16:06:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:43 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:43 INFO - 'USER': 'cltbld', 16:06:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:43 INFO - 'XPC_FLAGS': '0x0', 16:06:43 INFO - 'XPC_SERVICE_NAME': '0', 16:06:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-nZKcd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-FzZQeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-sABTd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-0CFRDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rvipXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-q3alwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jQXYPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-R9tV4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:44 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-REkGUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-uJJT3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-NtIxGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-2lJ9XC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-AYkYGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-KGbyM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-SmodeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-XStxwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:45 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-HsXt5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:45 INFO - Running setup.py install for manifestparser 16:06:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:46 INFO - Running setup.py install for mozcrash 16:06:46 INFO - Running setup.py install for mozdebug 16:06:46 INFO - Running setup.py install for mozdevice 16:06:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:06:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:46 INFO - Running setup.py install for mozfile 16:06:46 INFO - Running setup.py install for mozhttpd 16:06:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:46 INFO - Running setup.py install for mozinfo 16:06:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:46 INFO - Running setup.py install for mozInstall 16:06:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Running setup.py install for mozleak 16:06:47 INFO - Running setup.py install for mozlog 16:06:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Running setup.py install for moznetwork 16:06:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Running setup.py install for mozprocess 16:06:47 INFO - Running setup.py install for mozprofile 16:06:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:47 INFO - Running setup.py install for mozrunner 16:06:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:48 INFO - Running setup.py install for mozscreenshot 16:06:48 INFO - Running setup.py install for moztest 16:06:48 INFO - Running setup.py install for mozversion 16:06:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:48 INFO - Cleaning up... 16:06:48 INFO - Return code: 0 16:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:48 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:48 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 16:06:48 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 16:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:48 INFO - 'HOME': '/Users/cltbld', 16:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:48 INFO - 'LOGNAME': 'cltbld', 16:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:48 INFO - 'MOZ_NO_REMOTE': '1', 16:06:48 INFO - 'NO_EM_RESTART': '1', 16:06:48 INFO - 'PAGER': '/bin/cat', 16:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:48 INFO - 'PWD': '/builds/slave/test', 16:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:48 INFO - 'SHELL': '/bin/bash', 16:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:48 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:48 INFO - 'USER': 'cltbld', 16:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:48 INFO - 'XPC_FLAGS': '0x0', 16:06:48 INFO - 'XPC_SERVICE_NAME': '0', 16:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:48 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-FA3XKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:48 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)) 16:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:48 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-hUeNDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:48 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)) 16:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:48 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-UMgCWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8eVh5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-B_6QRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-HE6vml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-nA8LSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-oUPub6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-an9M9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ziB9CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-siBJWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:49 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)) 16:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:49 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-YxD839-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:50 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)) 16:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-U5PAFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:50 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)) 16:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-NRX3A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:50 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)) 16:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-GMPzXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:50 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)) 16:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Qc6wQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:50 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)) 16:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:50 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-YYnaNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:50 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)) 16:06:50 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)) 16:06:50 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)) 16:06:50 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)) 16:06:50 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)) 16:06:50 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)) 16:06:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:52 INFO - Downloading blessings-1.6.tar.gz 16:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:53 INFO - Installing collected packages: blessings 16:06:53 INFO - Running setup.py install for blessings 16:06:53 INFO - Successfully installed blessings 16:06:53 INFO - Cleaning up... 16:06:53 INFO - Return code: 0 16:06:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:53 INFO - Reading from file tmpfile_stdout 16:06:53 INFO - Current package versions: 16:06:53 INFO - blessings == 1.6 16:06:53 INFO - blobuploader == 1.2.4 16:06:53 INFO - docopt == 0.6.1 16:06:53 INFO - manifestparser == 1.1 16:06:53 INFO - mozInstall == 1.12 16:06:53 INFO - mozcrash == 0.17 16:06:53 INFO - mozdebug == 0.1 16:06:53 INFO - mozdevice == 0.48 16:06:53 INFO - mozfile == 1.2 16:06:53 INFO - mozhttpd == 0.7 16:06:53 INFO - mozinfo == 0.9 16:06:53 INFO - mozleak == 0.1 16:06:53 INFO - mozlog == 3.1 16:06:53 INFO - moznetwork == 0.27 16:06:53 INFO - mozprocess == 0.22 16:06:53 INFO - mozprofile == 0.28 16:06:53 INFO - mozrunner == 6.11 16:06:53 INFO - mozscreenshot == 0.1 16:06:53 INFO - mozsystemmonitor == 0.0 16:06:53 INFO - moztest == 0.7 16:06:53 INFO - mozversion == 1.4 16:06:53 INFO - psutil == 3.1.1 16:06:53 INFO - requests == 1.2.3 16:06:53 INFO - wsgiref == 0.1.2 16:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:53 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:53 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 16:06:53 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 16:06:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:53 INFO - 'HOME': '/Users/cltbld', 16:06:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:53 INFO - 'LOGNAME': 'cltbld', 16:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:53 INFO - 'MOZ_NO_REMOTE': '1', 16:06:53 INFO - 'NO_EM_RESTART': '1', 16:06:53 INFO - 'PAGER': '/bin/cat', 16:06:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:53 INFO - 'PWD': '/builds/slave/test', 16:06:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:53 INFO - 'SHELL': '/bin/bash', 16:06:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:53 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:53 INFO - 'USER': 'cltbld', 16:06:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:53 INFO - 'XPC_FLAGS': '0x0', 16:06:53 INFO - 'XPC_SERVICE_NAME': '0', 16:06:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 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)) 16:06:53 INFO - Cleaning up... 16:06:53 INFO - Return code: 0 16:06:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:53 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:53 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 16:06:53 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 16:06:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:53 INFO - 'HOME': '/Users/cltbld', 16:06:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:53 INFO - 'LOGNAME': 'cltbld', 16:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:53 INFO - 'MOZ_NO_REMOTE': '1', 16:06:53 INFO - 'NO_EM_RESTART': '1', 16:06:53 INFO - 'PAGER': '/bin/cat', 16:06:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:53 INFO - 'PWD': '/builds/slave/test', 16:06:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:53 INFO - 'SHELL': '/bin/bash', 16:06:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:53 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:53 INFO - 'USER': 'cltbld', 16:06:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:53 INFO - 'XPC_FLAGS': '0x0', 16:06:53 INFO - 'XPC_SERVICE_NAME': '0', 16:06:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:54 INFO - Downloading/unpacking jsonschema 16:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:06:56 INFO - Downloading/unpacking functools32 (from jsonschema) 16:06:56 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 16:06:56 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 16:06:56 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 16:06:56 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 16:06:56 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 16:06:56 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 16:06:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:06:57 INFO - warning: no files found matching '*.txt' 16:06:57 INFO - no previously-included directories found matching 'build' 16:06:57 INFO - no previously-included directories found matching 'dist' 16:06:57 INFO - no previously-included directories found matching '.git*' 16:06:57 INFO - Installing collected packages: jsonschema, functools32 16:06:57 INFO - Running setup.py install for functools32 16:06:57 INFO - warning: no files found matching '*.txt' 16:06:57 INFO - no previously-included directories found matching 'build' 16:06:57 INFO - no previously-included directories found matching 'dist' 16:06:57 INFO - no previously-included directories found matching '.git*' 16:06:57 INFO - Successfully installed jsonschema functools32 16:06:57 INFO - Cleaning up... 16:06:57 INFO - Return code: 0 16:06:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:06:57 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')]} 16:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:57 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')]} 16:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:57 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 0x10750fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10751f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe26ac5bf70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, '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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:06:57 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 16:06:57 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 16:06:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:06:57 INFO - 'HOME': '/Users/cltbld', 16:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:06:57 INFO - 'LOGNAME': 'cltbld', 16:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:57 INFO - 'MOZ_NO_REMOTE': '1', 16:06:57 INFO - 'NO_EM_RESTART': '1', 16:06:57 INFO - 'PAGER': '/bin/cat', 16:06:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:57 INFO - 'PWD': '/builds/slave/test', 16:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:06:57 INFO - 'SHELL': '/bin/bash', 16:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:06:57 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:06:57 INFO - 'USER': 'cltbld', 16:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:57 INFO - 'XPC_FLAGS': '0x0', 16:06:57 INFO - 'XPC_SERVICE_NAME': '0', 16:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:57 INFO - Downloading/unpacking flake8 16:06:57 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 16:06:57 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 16:06:57 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 16:06:57 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 16:06:57 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 16:06:57 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 16:07:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:07:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:07:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:02 INFO - no previously-included directories found matching 'docs/_build' 16:07:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:07:02 INFO - Running setup.py install for pep8 16:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:02 INFO - no previously-included directories found matching 'docs/_build' 16:07:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:07:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:07:02 INFO - Cleaning up... 16:07:02 INFO - Return code: 0 16:07:02 INFO - Running post-action listener: _resource_record_post_action 16:07:02 INFO - Running post-action listener: _start_resource_monitoring 16:07:02 INFO - Starting resource monitoring. 16:07:02 INFO - ##### 16:07:02 INFO - ##### Running install step. 16:07:02 INFO - ##### 16:07:02 INFO - Running pre-action listener: _resource_record_pre_action 16:07:02 INFO - Running main action method: install 16:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:02 INFO - Reading from file tmpfile_stdout 16:07:02 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:02 INFO - Reading from file tmpfile_stdout 16:07:02 INFO - Output received: 16:07:02 INFO - Usage: mozinstall [options] installer 16:07:02 INFO - Options: 16:07:02 INFO - -h, --help show this help message and exit 16:07:02 INFO - -d DEST, --destination=DEST 16:07:02 INFO - Directory to install application into. [default: 16:07:02 INFO - "/builds/slave/test"] 16:07:02 INFO - --app=APP Application being installed. [default: firefox] 16:07:02 INFO - mkdir: /builds/slave/test/build/application 16:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:07:36 INFO - Reading from file tmpfile_stdout 16:07:36 INFO - Output received: 16:07:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:07:36 INFO - Running post-action listener: _resource_record_post_action 16:07:36 INFO - ##### 16:07:36 INFO - ##### Running run-tests step. 16:07:36 INFO - ##### 16:07:36 INFO - Running pre-action listener: _resource_record_pre_action 16:07:36 INFO - Running main action method: run_tests 16:07:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:07:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:07:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:07:36 INFO - 2016-05-05 16:07:36.518 screenresolution[3065:44527] starting screenresolution argv=screenresolution get 16:07:36 INFO - 2016-05-05 16:07:36.520 screenresolution[3065:44527] Display 0: 1600x1200x32@60 16:07:36 INFO - 2016-05-05 16:07:36.525 screenresolution[3066:44529] starting screenresolution argv=screenresolution list 16:07:36 INFO - Available Modes on Display 0 16:07:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:07:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:07:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:07:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:07:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:07:36 INFO - Intel Iris: 16:07:36 INFO - Chipset Model: Intel Iris 16:07:36 INFO - Type: GPU 16:07:36 INFO - Bus: Built-In 16:07:36 INFO - VRAM (Dynamic, Max): 1536 MB 16:07:36 INFO - Vendor: Intel (0x8086) 16:07:36 INFO - Device ID: 0x0a2e 16:07:36 INFO - Revision ID: 0x0009 16:07:36 INFO - Displays: 16:07:36 INFO - Display: 16:07:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:07:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:07:36 INFO - Display Serial Number: 1600x1200 60 16:07:36 INFO - Main Display: Yes 16:07:36 INFO - Mirror: Off 16:07:36 INFO - Online: Yes 16:07:36 INFO - Rotation: Supported 16:07:36 INFO - Return code: 0 16:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:36 INFO - Python 2.7.3 16:07:36 INFO - Return code: 0 16:07:36 INFO - grabbing minidump binary from tooltool 16:07: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')]} 16:07:36 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 0x1073aee00>, '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 0x1071d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1073a9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:36 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 16:07:36 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 16:07:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:36 INFO - Return code: 0 16:07:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:07:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:07:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:07:37 INFO - Return code: 0 16:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 16:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 16:07:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.58Jaz1nvkp/Render', 16:07:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:07:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:07:37 INFO - 'HOME': '/Users/cltbld', 16:07:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:07:37 INFO - 'LOGNAME': 'cltbld', 16:07:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:37 INFO - 'MOZ_NO_REMOTE': '1', 16:07:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:37 INFO - 'NO_EM_RESTART': '1', 16:07:37 INFO - 'PAGER': '/bin/cat', 16:07:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:37 INFO - 'PWD': '/builds/slave/test', 16:07:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:07:37 INFO - 'SHELL': '/bin/bash', 16:07:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cVgnwduzmQ/Listeners', 16:07:37 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:07:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:07:37 INFO - 'USER': 'cltbld', 16:07:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:07:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:37 INFO - 'XPC_FLAGS': '0x0', 16:07:37 INFO - 'XPC_SERVICE_NAME': '0', 16:07:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:07:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 16:07:38 INFO - mozversion application_buildid: 20160505142107 16:07:38 INFO - mozversion application_changeset: daa53f98b541117b380d848f34eb00570ae71d2b 16:07:38 INFO - mozversion application_display_name: Nightly 16:07:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:38 INFO - mozversion application_name: Firefox 16:07:38 INFO - mozversion application_remotingname: firefox 16:07:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:07:38 INFO - mozversion application_vendor: Mozilla 16:07:38 INFO - mozversion application_version: 49.0a1 16:07:38 INFO - mozversion platform_buildid: 20160505142107 16:07:38 INFO - mozversion platform_changeset: daa53f98b541117b380d848f34eb00570ae71d2b 16:07:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:07:38 INFO - mozversion platform_version: 49.0a1 16:07:38 INFO - using testdate: 1462489658 16:07:38 INFO - actual date: 1462489658 16:07:38 INFO - starting webserver on 'localhost:49502' 16:07:38 INFO - SUITE-START | Running 2 tests 16:07:38 INFO - TEST-START | dromaeo_css 16:07:38 INFO - operating with platform_type : mac_ 16:07:38 INFO - Initialising browser for dromaeo_css test... 16:07:38 INFO - TEST-INFO | started process 3084 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmphIt0xf/profile http://localhost:49502/getInfo.html) 16:07:40 INFO - PROCESS | 3084 | __metrics Screen width/height:1600/1200 16:07:40 INFO - PROCESS | 3084 | colorDepth:24 16:07:40 INFO - PROCESS | 3084 | Browser inner width/height: 1024/689 16:07:40 INFO - PROCESS | 3084 | __metrics 16:07:40 INFO - PROCESS | 3084 | 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" 16:07:40 ERROR - PROCESS | 3084 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:07:41 INFO - TEST-INFO | 3084: exit 0 16:07:41 INFO - Browser initialized. 16:07:41 INFO - Running cycle 1/1 for dromaeo_css test... 16:07:41 INFO - TEST-INFO | started process 3086 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmphIt0xf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:53 INFO - PROCESS | 3086 | RSS: Main: 239165440 16:07:53 INFO - PROCESS | 3086 | 16:08:44 INFO - PROCESS | 3086 | 1462489724677 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] 16:10:54 INFO - PROCESS | 3086 | Cycle 1(1): loaded http://localhost:49502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49502/tests/dromaeo/cssquery-ext.html) 16:10:56 INFO - PROCESS | 3086 | RSS: Main: 379428864 16:10:56 INFO - PROCESS | 3086 | 16:13:59 INFO - PROCESS | 3086 | Cycle 1(1): loaded http://localhost:49502/tests/dromaeo/cssquery-ext.html (next: http://localhost:49502/tests/dromaeo/cssquery-jquery.html) 16:14:00 INFO - PROCESS | 3086 | RSS: Main: 371621888 16:14:00 INFO - PROCESS | 3086 | 16:17:02 INFO - PROCESS | 3086 | Cycle 1(1): loaded http://localhost:49502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49502/tests/dromaeo/cssquery-mootools.html) 16:17:02 INFO - PROCESS | 3086 | RSS: Main: 372543488 16:17:02 INFO - PROCESS | 3086 | 16:20:05 INFO - PROCESS | 3086 | Cycle 1(1): loaded http://localhost:49502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49502/tests/dromaeo/cssquery-prototype.html) 16:20:05 INFO - PROCESS | 3086 | RSS: Main: 369197056 16:20:05 INFO - PROCESS | 3086 | 16:23:09 INFO - PROCESS | 3086 | Cycle 1(1): loaded http://localhost:49502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49502/tests/dromaeo/cssquery-yui.html) 16:23:09 INFO - PROCESS | 3086 | RSS: Main: 346333184 16:23:09 INFO - PROCESS | 3086 | 16:26:12 INFO - PROCESS | 3086 | Cycle 1(1): loaded http://localhost:49502/tests/dromaeo/cssquery-yui.html (next: http://localhost:49502/tests/dromaeo/cssquery-dojo.html) 16:26:12 INFO - PROCESS | 3086 | RSS: Main: 420569088 16:26:12 INFO - PROCESS | 3086 | 16:26:12 INFO - PROCESS | 3086 | __start_tp_report 16:26:12 INFO - PROCESS | 3086 | _x_x_mozilla_page_load 16:26:12 INFO - PROCESS | 3086 | _x_x_mozilla_page_load_details 16:26:12 INFO - PROCESS | 3086 | |i|pagename|runs| 16:26:12 INFO - PROCESS | 3086 | |0;dojo.html;3418.72650187985;3437.0719905625483;3456.187795867969;3457.239407330388;3508.0352902951686;5615.101583746601;5653.462921022501;5690.345610254822;5763.798267060653;5785;5755.136729490579;5805.3323867755225;5846.269216347957;5861.296644402667;5910.67491287979;5139.717315547643;5159.638825282232;5227.73861306935;5229;5347.679139251657;5329.094054010808;5366.141417373221;5372.57019438446;5380.112281473572;5403.594730395216;5162.019216348919;5162.277281180656;5218.817341393071;5225.790968361261;5234.607404444682;5196.220566914955;5213.817516386946;5215.791368345262;5256.894862102737;5329.467053294678;5159;5178.533931946143;5182;5245.6852588844795;5266.815661451831;5548.86127846803;5627.296587926509;5702.315722113373;5723.942760572382;5785.942140578624;6247.9687601562155;6255.155554000243;6299.338569450233;6327.8734425311695;6336.429721325103;6278.717457714414;6281.152044473984;6282.748690052393;6308.085327627468;6313.873722525524;5739.167820666022;5756.30924289088;5791.88416231673;5883.529317654577;5972.910406343908;6262.6868656566985;6287.2140982377205;6301.369863013753;6302.275238347649;6302.464290535264;6155.2921414037955;6156.6921653917125;6161.199044124235;6170.50635949123;6186.257649082049;6159.876802463926;6210.130581718563;6281.8743625127245;6295.96852015737;6303.180586523723;6228.22147231596;6308.085327627468;6314.116023756677;6314.71583778731;6329.588576742497;6228.28374736902;6316.8420789479715;6328;6343.5876668016435;6348.587341822767;4894.926576101361;4928.531789479994;4956.008798240367;4997.975010124999;5007.524285192901;4479.955200448019;4516.570925762047;4524.954750452519;4526.864194074183;4540.886477838015;5786.334571524244;5789.305283366023;5791.913121303184;5814.76740930358;5814.854628634233;6019.638821670714;6174.969125154345;6247.156633854463;6257.4681152102585;6271.937280627135;5649.858753531194;5769.105788602689;5836.095405212199;5849.678267695318;5854.912176317359;4782.210935195723;5461.2354270402175;5490.423505531861;5500.28496295487;5505.917411238835;6314.116023756677;6330.525210609223;6356.904646430307;6388.776392826228;6495.642739649365;6237.781677641261;6277.780277690259;6284.780032698834;6294.8426289341305;6302.684865756785;6224.688765561795;6455.386738259858;6467.126937863328;6474.449671777763;6480.222373315232;6138.51101655979;6147.139400483847;6191.907121393093;6265.843353916189;6268.216472940882;6257.874842503215;6273.71768270438;6280.214973128359;6282.3089460158435;6290.779822706183;6013.939860601338;6102.359252278625;6149.846253843511;6151.477124444294;6172.845678858064;6124.173236613178;6163.445289923929;6178.382161783786;6182.969085154546;6185.319614842274;5860.765569377348;6020.247469066367;6037.577369584263;6057.606255593372;6094.695265236632;6014.278286605635;6123.326434092157;6127.3566275540425;6138.07928810682;6164.106204600397;6079.392060794062;6095.420935011167;6102.847428814315;6119.898418284752;6134.6625935573975 16:26:12 INFO - PROCESS | 3086 | |1;ext.html;498.03629975996427;502.9874253143672;503.5769953239279;513.8484147176582;555.2864569028794;30876.610552525133;31463;42879.35680964784;43713.34429983553;43923.56076439234;42425.575744242546;45059;45214.77392613041;45231.77384113083;45246.0950780985;9614.423134611929;9793.461359625218;9808.31341806074;9809.50952452378;9814.165795907356;9571.569279382444;9683.612655493771;9686.612535498572;9690.418574885494;9700.660476883311;8264.421490495668;9730.756731081708;9732.805343893118;9740.659076932308;9754.853677194847;9693.273004524688;9706.75733106678;9708.077732615391;9710.563024663907;9718.271129665303;8184.6316915738935;9594.280428967786;9667.226621870233;9669.70990870275;9676.709698708979;41435.37846932298;41895.58104418947;41903;41949.370759438636;41987;2640.7755340796057;3201.855916483764;3256.5766450361302;3261.4129456697783;3439.5725773803842;29073.709262907523;29634.55548166779;30283.545746813594;30289.242768930733;30735.231619209477;2532.4935012997475;2633.6436735081447;2765.7372549607753;2772.5979732938613;2893.7250961158657;480847;481645.18354816356;482661;485584.99999999645;488338;35459.82270088633;36449.453258201145;65034;65660;65790.67104664446;37706.43440348397;37770;37898.43152352717;37937.24125517474;37979.62020379761;15451.072935623899;15640;15662.37350505967;15662.82528810321;15728.370865165494;12743.235405875677;12775.23348599087;12813;12813.487460501476;12823.294718790556;8269.04905935813;8273.379496537784;8293.58532073406;8348.874766878502;8361.707340243183;3444.190615205425;3469.5366289934427;3478.286951175003;3486.4770284457027;3495.1262184453885;998.4009594243541;1054.488573042074;1103.784761971424;1134.7446824464594;1176.8705442401329;24783.25650230496;29296.56055159174;29551.817927283097;29787.851060744557;30612;916.3722849847876;1016.6492560066765;1178.1046404732465;1190.220405634311;1248.0452453872795;15344.616384590474;15434.84565154334;15465.536033918776;15475.916685831884;15928.92035539838;649003;663222;671088;672342;672940;60789.392106079256;61164;61372.38627613756;61437.078443823375;61451.07823382653;1332.1474256475863;1472.9189894555689;1489.3670190169134;1513.954581362561;1525.6185953511622;25274.620880687173;28133.175501596324;29019.85490072536;29402.264943376587;32099.71601136022;50605.98788024292;50942;51308.23037654364;51393.20123795649;51690.74154629353;513605;514937;516049;516762;518073;23398.415039624146;26042.34894127662;26860.05989790348;27043.86478067597;27176.1847144586;46871.76564117294;47004.764976176266;47479.25207479363;47987;48349.75825120852;37215;37777.24445511129;38222.044448887886;38805.80597096997;39062.2187556253;37877;37901.431478527295;38202.617973819906;38902.80548597239;39063.41404878986;35007.124821878635;37472;37877.81061094677;38912.41631375475;38932.6106738929;31008.844955775076;33527.82652607147;33704;33897.830510847285;33956.64173433035;23717;24237.151699690425;24541.631875521525;24900.501989959736;25349.493010140064 16:26:12 INFO - PROCESS | 3086 | |2;jquery.html;376.3714596623639;398.76672146794124;398.96409323160907;399.95400528939183;425.9467566554181;20625.27811526597;20690.482737931557;21798.346049618496;21977.890110549444;22049.338519844412;12124.636260912164;12447.004239660828;17432.215550300236;21279.57440851182;21294.57410851782;5371.113766228577;5559.054960656698;5860.882782344372;6227.532935029868;6235.906461403082;6178.598391104564;6198.380161983788;6221.906671399933;6225.252969643627;6241.781537646183;6406.423421892029;6862.656867156647;6863.4166095881665;6883.931160688404;6891.965540172292;6212.689365531751;6233.657148856811;6687.832804179886;6807;6908.032875397448;5874.118882167666;6047.939520604826;6071.453569178795;6072.5445591580365;6075.513958883279;24568.631470527955;25419.61870571943;25975.090871819586;25980.830862611227;26724.931002759866;2092.3618296419586;2093.058123844276;2157.234181865431;2211.1929145861645;2618.2276228512633;9828.705138845846;9979.10188083076;10143.442110683909;10184.541695623715;10455.790884182274;1492.9104253744702;1729.1267909705643;1792.050213386907;1796.6765982123213;1874.4189301316635;128227.35886320508;128324.35837820845;128743;129396;130737;11527.48126334317;11743.41282935867;11797.705057373463;11807.940960295315;11979.700507487209;15481.225938703019;15599.454019109276;15605.297761600756;15609.219539023003;15628.140452275007;8841.469511829311;8864.468131912106;8953.015168331478;8954.776130596787;9058.954705226432;7873.842523149505;8075.838483230303;8768.824623507622;8800.427972181787;8920.464772113693;4686.7656617169005;4695.272232803921;4710.434747830213;4718.245080787057;4733.763311834395;1759.357834390464;1848.7798053284766;1915.9233630654617;1974.299123811055;1977.1103003648416;777.8249893773968;826.9415148609789;925.1858364639209;952.7808604021114;959.3572306554626;17527.900401765735;20894.686579701316;20997;21016.579668406546;21080.78919210788;989.7575094101848;994.8259054665405;1005.6429967361628;1035.2649618770606;1037.5953378182514;9755.563626593996;10936.434031322235;10955.4522273886;10979.341239525655;10991.395473249047;561595;585922;595383;595695;599467.0026649839;82010.58994704988;117509.99999999828;121705;138824.8013727846;145344;961.9855702164473;967.777411195415;980.1081016275298;999.5551979369111;999.6251405722854;18132.002739849435;18835.340763073225;18900.527486812938;19020.635408101734;19052.904735476233;42187;51512.535841493605;51572.48427515677;52442.475575245284;53664.73167634137;67052.3294767046;67904.2281406086;69144;69651.65174174096;72031;8113.18868113184;8149.837003259783;8169.856220129305;8363.414560980673;8382.455140415854;11418.31490110596;11993.940030299793;12528;12947.223166609656;12975.416106275052;9951.303408761607;10140.645077422254;10807.513661885077;10910.509027093642;11229.66311010671;8664.093899342135;10763.3541987481;10901.182411319342;11043;11068.169887258327;10835.458227088771;11084.445777711244;11469.369184694922;11476.483558239732;11521.769564608829;8061.83876322482;8155.469894456842;8186.83626327482;8262.586870656323;8451.661933522837;10558.155347572023;10993.120550355792;11221.60724374643;11281.887181128412;11301.830472542753 16:26:12 INFO - PROCESS | 3086 | |3;mootools.html;1431.6277767780373;1584.112896777804;1598.001249219238;1846.4091490722965;1955.941321760347;7755.991721076266;7893.960530197348;8586.398952073358;8872.20150186483;8889.28885689144;8673.262772664331;8927.41971771836;8931.910680893188;8944.508052057134;8951.910480895189;2477.2444404456633;2520.143151328548;2522.583773677341;2523.5836087045614;2523.974760252392;2459.532688789124;2505.549001179787;2515;2516.5721827289312;2517.2699917024133;2473.9628905566433;2490.1657944588583;2510.79913606911;2513.1204078572537;2514.245726282117;1977.812107849752;1991.4523506035812;2392.760723927602;2426.4540478392396;2443.2914454808083;2438.296475363359;2473.2085732565406;2473.4558397152596;2478.5538603051446;2487.2786891801356;7548.73579424723;8446.197611226924;8758.211760941545;8830.779230519223;8839.02770695223;5400.648957817729;5530.778768849241;5561.360443549003;5572.916406253868;5577.972110139423;3523.71810255179;3653.0319465341704;3728.4780130781714;3729.5710993235584;3758.0980564664555;909.8771665825095;1054.3410368519676;1063.1760385701143;1065.3607835298758;1065.55779351569;11850.992665623433;11990.520379184822;11994.040476761838;12008.099392545593;12010.879891201152;4621.23749581322;4679.742614156186;4792.305115758196;4807.18277892759;4813.614910807127;9370;9376.343655944154;9384.95307523458;9396.342256042011;9416.764580885532;5422.8915421691345;5455.754491047913;5456.045192091368;5464;5465.945340546544;4173.499180098408;4502.482214545304;4698.906021879543;4923.359963204832;5035.647504674711;3871.4192871069563;3907.9609203908167;3931.1548017176447;3970.2059588082498;4002.478438583732;1211.2671833540758;1226.760781647588;1229.8155276708565;1238.9566365177175;1242.0932719115096;840.6805413942785;919.2921450483224;921.0697195832257;927.3693888155984;941.7033634405141;5950.761969521171;6062.120992456069;6148.631082135086;6212.844678883064;6325.399087086719;958.6453012385323;981.6956743409565;987.0820137272262;1005.7787286796893;1034.1209971524145;3370.898873033813;3916.472575695481;3976.781277029791;4007.338789099766;4083.9795801020805;10233.48832558369;10427.478626068667;10677.09244714208;10716.196285278635;10721.98141176587;10582.994615511514;10640.733981650366;10751.086157676686;10769.83845242322;10789.298695584763;8013.599320033975;8269;8279.047909490366;8382.958085209657;8386.371022173484;5883.441073098049;5927.9703601481715;6003.519718422603;6016.368281330572;6067.666278354556;9985.301028927905;10258.794824103625;10297.485125743533;10303.278770486293;10307.123894469054;9957.651482198089;10109.545070471993;10385.013423724735;10393.740156496147;10504.789904202025;6377.553571249968;6720.731170753115;6784.08414863987;7087.7164913402885;7089;8438.53588052663;8489.278411335106;8595.18345757152;8599.355048371272;8603.053664096818;7098.858022839618;7533.434992375484;7628.80927976805;7641.847163056819;7795.41534384912;7372.63136843145;7397.408207343292;7474.775756727089;7630.236976302325;7632.923670763222;7083.574985500886;7147.82130446743;7161.677724502306;7166.605836678824;7168.67740951648;4310.181065597527;4817.723303324692;4836;5087.92368114486;5106.46382129871;5031.295618613471;5090.134677104975;5091.1854103343285;5162.561182299547;5313.707746074003 16:26:12 INFO - PROCESS | 3086 | |4;prototype.html;307.6692555502834;319.85926192475307;323.5001922030462;326.8872239077519;332;4144.792760361981;4549.795259213335;5159.587233021359;5229.7385130743505;5232.529072383485;4368.907773056736;5182.341650671787;5192.3249977502965;5202.661826981243;5215.843524694255;3766.2090960898245;3832.8466861325514;3897.3569361055534;3973.284808734427;4050.9797451012705;3808.257389808988;3926.685865130797;3951.1505026419313;3986.8869499165344;4041.8376168749724;3654.6528079832374;3804.353259945802;3984.8007599620046;3988.9002774930714;3990.7805070721097;3360.512725654766;3525.770824896399;3774.4904437900805;3841.654251117385;3927.5286965564173;2963.6739958604535;3159.699828516287;3195.2745517420567;3248.0418276608457;3499.772514786531;4549.134854709553;4635.4210865235245;4989.800407983676;5018.77415516299;5027.235020738579;3814.6757525610356;4550.158220729142;4578.587927086578;4591.357209990604;4605.355250264965;4999.975000124976;5325.201219817059;5406.783728650849;5412.864678383072;5413.350397952231;3089.845507724605;3418.4017796885446;3819.140693344003;3840.635139661728;3860;4329.913401731979;5686.346070201938;5730.942690573124;5733.426657334275;5739.494496820018;3329.334133173375;3628.258435950758;3902.083010492532;3939.428782826474;3962;3826.2972977025515;3952.1898010907694;3956.248312820555;3960.603939606074;3972.1857019310974;3535.292941411728;4196.538380778112;4530.139273538083;4543.659225558096;4574.817007319736;4681.976590117028;5078.949210507922;5159.406668233201;5467.398586155519;5528.419515950848;1094.5348227003492;1183.5088438298183;1237.9257244565174;1246.426643743888;1263.6082814327588;831.6216121664628;840.2060053249743;848.7538613801928;865.2774932931073;875.8905136857893;4629.583337499574;4884.682495637843;4962.950370496249;5076.593872490192;5117.948820511747;4881.389826271716;5144;5558.694271815089;5578.386377498472;5591.049521581341;4371.103923695635;4486.327050942385;4900.26496025599;5073.594112470993;5076.111680455905;2512.459821138464;2811.493931092382;2828.5474324108045;2842.7349829326163;2843.45974264889;4623.237165867661;5033.899322013613;5373.650712703662;5561.777528898799;5576.665400076008;5191.610629202825;5360.785568577291;5405.21624364465;5483.080921677381;5532.280803495601;4840.878978025577;4928;4954.6646684151365;5484.232207490954;5649.802256920988;4679.976600116977;4775.373544550553;4791.305260737243;4840.515948405272;4973.701577905337;4179.9582004179565;5259.105951988247;5279.656822306538;5298.523132918056;5330.200469929541;4950.900981980412;4959;5362.651427657346;5604.915926261191;5646.915296270641;3358.580177477815;3433.6738009889023;3593.604703482667;3610.598951697197;3614.2109655720587;4731.053789242096;4819.638527110551;4902.3872015998;5269.417985187307;5320.0955837506945;4769.809207631656;5061.39263288393;5156.922646160236;5168.664036837594;5170.974145129401;4643.421236779511;4828.517148285144;4920.277902734015;5037.974810125926;5114.514121158484;4294.39581346346;4837.661363704507;5000.613301278063;5007.697998520338;5028.058585727391;5175.611829112756;5208.348956380452;5278.656887302313;5328.868452618984;5453.7818487260065;5316.272211531191;5322.0154271459905;5326.786928522971;5331.893362132658;5345.4654534546235 16:26:12 INFO - PROCESS | 3086 | |5;yui.html;573.3062993777529;665.9334066593339;723.7901008707473;733.3729661139722;799.420420195358;14375;14804.851951480481;15072.77390839137;15093.320800563974;15655.608609784762;12371.443285052172;13988.58034258974;14294.428222871073;14426.783598246035;14518.201498917555;746.9663865126055;765.1506827421557;912.5026860361086;916.5737931861667;945.6595625574788;936.4334577580534;942.9387089839173;943.6178347769164;943.7451887990238;945.754103932979;1005.1305620638132;1006.8892421833592;1009.0363702663975;1009.9394036357842;1011.357787804742;776.1036003416064;956.516958935733;982.641335912394;985.8324084905584;988.9653862114827;742.3912391838694;742.524784138152;744.270614797496;744.9515781474241;747.9887801682979;14602.12387256768;14660.266986650624;14670.926645366704;14692.191929443876;14698.33857476416;12244.326562039085;12285.754284914252;12343.580488243877;12394.814077788751;12602.432890519856;10588.523516441779;10830.187735919837;10996.670099897015;11011.889881101166;11264.887351126466;3976.9858686034877;3993.6605388542007;4001;4005.2590270799997;4011.7793521356316;74758.62620686916;76113;78209.82685259725;78224.21775782226;78892.42215155723;9577.521123943776;9607.615695372248;9629.374090684083;9847.55685994132;9862.950685246527;19874.490522093514;21158.78841211599;21180.78819211819;21186.258480953093;21243.893780531307;7474.289942455458;7552.358049565739;7704.6918123274445;7772.18392068836;7776.144624091346;4056.513218413809;4140.585941405896;4142.5857414258935;4186.623203911602;4420.469543654718;3585.731070169748;3637.0543658648944;3647.5805282392867;3684.8341824617955;3691.483192353073;657.050561937995;657.8750037492861;665.8583609946128;673.7978606418055;677.0893148714971;475.73358919005466;509.26157072245394;545.1250742558216;570.0594019867252;594.6432140715536;8041.7989550260545;8076.446681821993;8226.465279756796;8253.380996425292;8440.40917135807;471.36130543114274;578.288704892984;602.3645054467579;605.4702135631322;606.5784279925409;3886.5724770275247;3942.8225729842225;4014.0566966762785;4079.583192475171;4212.789360531961;77173.22826771773;79822.60088699519;79885.20114798893;92376.53811731032;94725.05274947162;71894;76909.61545192238;76911.61544192243;78505;79314;66219;69633.65183174051;70606.64696676689;71141.2885871145;71629.56740865154;8382.916170838214;8422.578871056545;8424.29652087618;8521.91478085236;8594.65621375138;42339.364909525764;44350.01699694086;45782.31326530172;46198.53801461942;46754.59736207919;60265.8906938255;63872;63947.360526396;64287;64372.356276438506;9509.524523773922;11297.830532542182;11370.147238956946;11387.601433949772;11569.710757231136;11875.940620296844;11912.940435297767;11921.403929803302;12066.155369124077;13333.20000799955;11702.648920532398;11850.940745296219;12207.267563946192;12256;12567.748645027232;11780.82328765052;11830.881691182978;12041.157119001937;12183;12290.385480725748;11500.424978751196;11512.19414640967;11640.952314291755;11722.355270460206;11884.762304753684;9567.186789123003;9686.418814871131;9855.655052073143;9937.403755774676;10101.09014903496;8954.910450895668;9083.818323633359;9452.858207126761;9729.562169702522;9938.155256802964 16:26:12 INFO - PROCESS | 3086 | __end_tp_report 16:26:12 INFO - PROCESS | 3086 | __start_cc_report 16:26:12 INFO - PROCESS | 3086 | _x_x_mozilla_cycle_collect,1388 16:26:12 INFO - PROCESS | 3086 | __end_cc_report 16:26:13 INFO - PROCESS | 3086 | __startTimestamp1462490772984__endTimestamp 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | ------- Summary: start ------- 16:26:13 INFO - PROCESS | 3086 | Number of tests: 6 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | [#0] dojo.html Cycles:165 Average:5797.86 Median:6079.39 stddev:637.68 (10.5%) stddev-sans-first:611.71 16:26:13 INFO - PROCESS | 3086 | Values: 3418.7 3437.1 3456.2 3457.2 3508.0 5615.1 5653.5 5690.3 5763.8 5785.0 5755.1 5805.3 5846.3 5861.3 5910.7 5139.7 5159.6 5227.7 5229.0 5347.7 5329.1 5366.1 5372.6 5380.1 5403.6 5162.0 5162.3 5218.8 5225.8 5234.6 5196.2 5213.8 5215.8 5256.9 5329.5 5159.0 5178.5 5182.0 5245.7 5266.8 5548.9 5627.3 5702.3 5723.9 5785.9 6248.0 6255.2 6299.3 6327.9 6336.4 6278.7 6281.2 6282.7 6308.1 6313.9 5739.2 5756.3 5791.9 5883.5 5972.9 6262.7 6287.2 6301.4 6302.3 6302.5 6155.3 6156.7 6161.2 6170.5 6186.3 6159.9 6210.1 6281.9 6296.0 6303.2 6228.2 6308.1 6314.1 6314.7 6329.6 6228.3 6316.8 6328.0 6343.6 6348.6 4894.9 4928.5 4956.0 4998.0 5007.5 4480.0 4516.6 4525.0 4526.9 4540.9 5786.3 5789.3 5791.9 5814.8 5814.9 6019.6 6175.0 6247.2 6257.5 6271.9 5649.9 5769.1 5836.1 5849.7 5854.9 4782.2 5461.2 5490.4 5500.3 5505.9 6314.1 6330.5 6356.9 6388.8 6495.6 6237.8 6277.8 6284.8 6294.8 6302.7 6224.7 6455.4 6467.1 6474.4 6480.2 6138.5 6147.1 6191.9 6265.8 6268.2 6257.9 6273.7 6280.2 6282.3 6290.8 6013.9 6102.4 6149.8 6151.5 6172.8 6124.2 6163.4 6178.4 6183.0 6185.3 5860.8 6020.2 6037.6 6057.6 6094.7 6014.3 6123.3 6127.4 6138.1 6164.1 6079.4 6095.4 6102.8 6119.9 6134.7 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | [#1] ext.html Cycles:180 Average:67817.42 Median:38513.93 stddev:150127.25 (389.8%) stddev-sans-first:150463.31 16:26:13 INFO - PROCESS | 3086 | Values: 498.0 503.0 503.6 513.8 555.3 30876.6 31463.0 42879.4 43713.3 43923.6 42425.6 45059.0 45214.8 45231.8 45246.1 9614.4 9793.5 9808.3 9809.5 9814.2 9571.6 9683.6 9686.6 9690.4 9700.7 8264.4 9730.8 9732.8 9740.7 9754.9 9693.3 9706.8 9708.1 9710.6 9718.3 8184.6 9594.3 9667.2 9669.7 9676.7 41435.4 41895.6 41903.0 41949.4 41987.0 2640.8 3201.9 3256.6 3261.4 3439.6 29073.7 29634.6 30283.5 30289.2 30735.2 2532.5 2633.6 2765.7 2772.6 2893.7 480847.0 481645.2 482661.0 485585.0 488338.0 35459.8 36449.5 65034.0 65660.0 65790.7 37706.4 37770.0 37898.4 37937.2 37979.6 15451.1 15640.0 15662.4 15662.8 15728.4 12743.2 12775.2 12813.0 12813.5 12823.3 8269.0 8273.4 8293.6 8348.9 8361.7 3444.2 3469.5 3478.3 3486.5 3495.1 998.4 1054.5 1103.8 1134.7 1176.9 24783.3 29296.6 29551.8 29787.9 30612.0 916.4 1016.6 1178.1 1190.2 1248.0 15344.6 15434.8 15465.5 15475.9 15928.9 649003.0 663222.0 671088.0 672342.0 672940.0 60789.4 61164.0 61372.4 61437.1 61451.1 1332.1 1472.9 1489.4 1514.0 1525.6 25274.6 28133.2 29019.9 29402.3 32099.7 50606.0 50942.0 51308.2 51393.2 51690.7 513605.0 514937.0 516049.0 516762.0 518073.0 23398.4 26042.3 26860.1 27043.9 27176.2 46871.8 47004.8 47479.3 47987.0 48349.8 37215.0 37777.2 38222.0 38805.8 39062.2 37877.0 37901.4 38202.6 38902.8 39063.4 35007.1 37472.0 37877.8 38912.4 38932.6 31008.8 33527.8 33704.0 33897.8 33956.6 23717.0 24237.2 24541.6 24900.5 25349.5 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | [#2] jquery.html Cycles:180 Average:34543.83 Median:14671.58 stddev:98253.38 (669.7%) stddev-sans-first:98495.51 16:26:13 INFO - PROCESS | 3086 | Values: 376.4 398.8 399.0 400.0 425.9 20625.3 20690.5 21798.3 21977.9 22049.3 12124.6 12447.0 17432.2 21279.6 21294.6 5371.1 5559.1 5860.9 6227.5 6235.9 6178.6 6198.4 6221.9 6225.3 6241.8 6406.4 6862.7 6863.4 6883.9 6892.0 6212.7 6233.7 6687.8 6807.0 6908.0 5874.1 6047.9 6071.5 6072.5 6075.5 24568.6 25419.6 25975.1 25980.8 26724.9 2092.4 2093.1 2157.2 2211.2 2618.2 9828.7 9979.1 10143.4 10184.5 10455.8 1492.9 1729.1 1792.1 1796.7 1874.4 128227.4 128324.4 128743.0 129396.0 130737.0 11527.5 11743.4 11797.7 11807.9 11979.7 15481.2 15599.5 15605.3 15609.2 15628.1 8841.5 8864.5 8953.0 8954.8 9059.0 7873.8 8075.8 8768.8 8800.4 8920.5 4686.8 4695.3 4710.4 4718.2 4733.8 1759.4 1848.8 1915.9 1974.3 1977.1 777.8 826.9 925.2 952.8 959.4 17527.9 20894.7 20997.0 21016.6 21080.8 989.8 994.8 1005.6 1035.3 1037.6 9755.6 10936.4 10955.5 10979.3 10991.4 561595.0 585922.0 595383.0 595695.0 599467.0 82010.6 117510.0 121705.0 138824.8 145344.0 962.0 967.8 980.1 999.6 999.6 18132.0 18835.3 18900.5 19020.6 19052.9 42187.0 51512.5 51572.5 52442.5 53664.7 67052.3 67904.2 69144.0 69651.7 72031.0 8113.2 8149.8 8169.9 8363.4 8382.5 11418.3 11993.9 12528.0 12947.2 12975.4 9951.3 10140.6 10807.5 10910.5 11229.7 8664.1 10763.4 10901.2 11043.0 11068.2 10835.5 11084.4 11469.4 11476.5 11521.8 8061.8 8155.5 8186.8 8262.6 8451.7 10558.2 10993.1 11221.6 11281.9 11301.8 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | [#3] mootools.html Cycles:180 Average:5743.07 Median:4977.33 stddev:3187.85 (64.0%) stddev-sans-first:3180.32 16:26:13 INFO - PROCESS | 3086 | Values: 1431.6 1584.1 1598.0 1846.4 1955.9 7756.0 7894.0 8586.4 8872.2 8889.3 8673.3 8927.4 8931.9 8944.5 8951.9 2477.2 2520.1 2522.6 2523.6 2524.0 2459.5 2505.5 2515.0 2516.6 2517.3 2474.0 2490.2 2510.8 2513.1 2514.2 1977.8 1991.5 2392.8 2426.5 2443.3 2438.3 2473.2 2473.5 2478.6 2487.3 7548.7 8446.2 8758.2 8830.8 8839.0 5400.6 5530.8 5561.4 5572.9 5578.0 3523.7 3653.0 3728.5 3729.6 3758.1 909.9 1054.3 1063.2 1065.4 1065.6 11851.0 11990.5 11994.0 12008.1 12010.9 4621.2 4679.7 4792.3 4807.2 4813.6 9370.0 9376.3 9385.0 9396.3 9416.8 5422.9 5455.8 5456.0 5464.0 5465.9 4173.5 4502.5 4698.9 4923.4 5035.6 3871.4 3908.0 3931.2 3970.2 4002.5 1211.3 1226.8 1229.8 1239.0 1242.1 840.7 919.3 921.1 927.4 941.7 5950.8 6062.1 6148.6 6212.8 6325.4 958.6 981.7 987.1 1005.8 1034.1 3370.9 3916.5 3976.8 4007.3 4084.0 10233.5 10427.5 10677.1 10716.2 10722.0 10583.0 10640.7 10751.1 10769.8 10789.3 8013.6 8269.0 8279.0 8383.0 8386.4 5883.4 5928.0 6003.5 6016.4 6067.7 9985.3 10258.8 10297.5 10303.3 10307.1 9957.7 10109.5 10385.0 10393.7 10504.8 6377.6 6720.7 6784.1 7087.7 7089.0 8438.5 8489.3 8595.2 8599.4 8603.1 7098.9 7533.4 7628.8 7641.8 7795.4 7372.6 7397.4 7474.8 7630.2 7632.9 7083.6 7147.8 7161.7 7166.6 7168.7 4310.2 4817.7 4836.0 5087.9 5106.5 5031.3 5090.1 5091.2 5162.6 5313.7 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | [#4] prototype.html Cycles:180 Average:4290.61 Median:4833.09 stddev:1293.87 (26.8%) stddev-sans-first:1262.49 16:26:13 INFO - PROCESS | 3086 | Values: 307.7 319.9 323.5 326.9 332.0 4144.8 4549.8 5159.6 5229.7 5232.5 4368.9 5182.3 5192.3 5202.7 5215.8 3766.2 3832.8 3897.4 3973.3 4051.0 3808.3 3926.7 3951.2 3986.9 4041.8 3654.7 3804.4 3984.8 3988.9 3990.8 3360.5 3525.8 3774.5 3841.7 3927.5 2963.7 3159.7 3195.3 3248.0 3499.8 4549.1 4635.4 4989.8 5018.8 5027.2 3814.7 4550.2 4578.6 4591.4 4605.4 5000.0 5325.2 5406.8 5412.9 5413.4 3089.8 3418.4 3819.1 3840.6 3860.0 4329.9 5686.3 5730.9 5733.4 5739.5 3329.3 3628.3 3902.1 3939.4 3962.0 3826.3 3952.2 3956.2 3960.6 3972.2 3535.3 4196.5 4530.1 4543.7 4574.8 4682.0 5078.9 5159.4 5467.4 5528.4 1094.5 1183.5 1237.9 1246.4 1263.6 831.6 840.2 848.8 865.3 875.9 4629.6 4884.7 4963.0 5076.6 5117.9 4881.4 5144.0 5558.7 5578.4 5591.0 4371.1 4486.3 4900.3 5073.6 5076.1 2512.5 2811.5 2828.5 2842.7 2843.5 4623.2 5033.9 5373.7 5561.8 5576.7 5191.6 5360.8 5405.2 5483.1 5532.3 4840.9 4928.0 4954.7 5484.2 5649.8 4680.0 4775.4 4791.3 4840.5 4973.7 4180.0 5259.1 5279.7 5298.5 5330.2 4950.9 4959.0 5362.7 5604.9 5646.9 3358.6 3433.7 3593.6 3610.6 3614.2 4731.1 4819.6 4902.4 5269.4 5320.1 4769.8 5061.4 5156.9 5168.7 5171.0 4643.4 4828.5 4920.3 5038.0 5114.5 4294.4 4837.7 5000.6 5007.7 5028.1 5175.6 5208.3 5278.7 5328.9 5453.8 5316.3 5322.0 5326.8 5331.9 5345.5 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - PROCESS | 3086 | [#5] yui.html Cycles:180 Average:17778.43 Median:575.80 stddev:24362.09 (4231.0%) stddev-sans-first:24396.18 16:26:13 INFO - PROCESS | 3086 | Values: 573.3 665.9 723.8 733.4 799.4 14375.0 14804.9 15072.8 15093.3 15655.6 12371.4 13988.6 14294.4 14426.8 14518.2 747.0 765.2 912.5 916.6 945.7 936.4 942.9 943.6 943.7 945.8 1005.1 1006.9 1009.0 1009.9 1011.4 776.1 956.5 982.6 985.8 989.0 742.4 742.5 744.3 745.0 748.0 14602.1 14660.3 14670.9 14692.2 14698.3 12244.3 12285.8 12343.6 12394.8 12602.4 10588.5 10830.2 10996.7 11011.9 11264.9 3977.0 3993.7 4001.0 4005.3 4011.8 74758.6 76113.0 78209.8 78224.2 78892.4 9577.5 9607.6 9629.4 9847.6 9863.0 19874.5 21158.8 21180.8 21186.3 21243.9 7474.3 7552.4 7704.7 7772.2 7776.1 4056.5 4140.6 4142.6 4186.6 4420.5 3585.7 3637.1 3647.6 3684.8 3691.5 657.1 657.9 665.9 673.8 677.1 475.7 509.3 545.1 570.1 594.6 8041.8 8076.4 8226.5 8253.4 8440.4 471.4 578.3 602.4 605.5 606.6 3886.6 3942.8 4014.1 4079.6 4212.8 77173.2 79822.6 79885.2 92376.5 94725.1 71894.0 76909.6 76911.6 78505.0 79314.0 66219.0 69633.7 70606.6 71141.3 71629.6 8382.9 8422.6 8424.3 8521.9 8594.7 42339.4 44350.0 45782.3 46198.5 46754.6 60265.9 63872.0 63947.4 64287.0 64372.4 9509.5 11297.8 11370.1 11387.6 11569.7 11875.9 11912.9 11921.4 12066.2 13333.2 11702.6 11850.9 12207.3 12256.0 12567.7 11780.8 11830.9 12041.2 12183.0 12290.4 11500.4 11512.2 11641.0 11722.4 11884.8 9567.2 9686.4 9855.7 9937.4 10101.1 8954.9 9083.8 9452.9 9729.6 9938.2 16:26:13 INFO - PROCESS | 3086 | -------- Summary: end -------- 16:26:13 INFO - PROCESS | 3086 | 16:26:13 INFO - TEST-INFO | 3086: exit 0 16:26:13 INFO - TEST-OK | dromaeo_css | took 1115481ms 16:26:13 INFO - TEST-START | kraken 16:26:13 INFO - operating with platform_type : mac_ 16:26:13 INFO - Initialising browser for kraken test... 16:26:13 INFO - TEST-INFO | started process 3088 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpQrq9nV/profile http://localhost:49502/getInfo.html) 16:26:16 INFO - PROCESS | 3088 | __metrics Screen width/height:1600/1200 16:26:16 INFO - PROCESS | 3088 | colorDepth:24 16:26:16 INFO - PROCESS | 3088 | Browser inner width/height: 1024/689 16:26:16 INFO - PROCESS | 3088 | __metrics 16:26:16 INFO - PROCESS | 3088 | 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" 16:26:16 ERROR - PROCESS | 3088 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:26:16 INFO - TEST-INFO | 3088: exit 0 16:26:16 INFO - Browser initialized. 16:26:16 INFO - Running cycle 1/1 for kraken test... 16:26:16 INFO - TEST-INFO | started process 3090 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpQrq9nV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:28 INFO - PROCESS | 3090 | RSS: Main: 239214592 16:26:28 INFO - PROCESS | 3090 | 16:26:31 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49502/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:32 INFO - PROCESS | 3090 | RSS: Main: 286711808 16:26:32 INFO - PROCESS | 3090 | 16:26:34 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49502/tests/kraken/driver.html?testName=audio-dft) 16:26:35 INFO - PROCESS | 3090 | RSS: Main: 295444480 16:26:35 INFO - PROCESS | 3090 | 16:26:39 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49502/tests/kraken/driver.html?testName=audio-fft) 16:26:39 INFO - PROCESS | 3090 | RSS: Main: 388313088 16:26:39 INFO - PROCESS | 3090 | 16:26:41 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49502/tests/kraken/driver.html?testName=audio-oscillator) 16:26:42 INFO - PROCESS | 3090 | RSS: Main: 285188096 16:26:42 INFO - PROCESS | 3090 | 16:26:44 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:26:45 INFO - PROCESS | 3090 | RSS: Main: 288862208 16:26:45 INFO - PROCESS | 3090 | 16:26:47 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49502/tests/kraken/driver.html?testName=imaging-darkroom) 16:26:48 INFO - PROCESS | 3090 | RSS: Main: 325701632 16:26:48 INFO - PROCESS | 3090 | 16:26:51 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49502/tests/kraken/driver.html?testName=imaging-desaturate) 16:26:51 INFO - PROCESS | 3090 | RSS: Main: 326774784 16:26:51 INFO - PROCESS | 3090 | 16:26:54 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49502/tests/kraken/driver.html?testName=json-parse-financial) 16:26:55 INFO - PROCESS | 3090 | RSS: Main: 325509120 16:26:55 INFO - PROCESS | 3090 | 16:26:56 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:26:57 INFO - PROCESS | 3090 | RSS: Main: 313012224 16:26:57 INFO - PROCESS | 3090 | 16:26:59 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:27:00 INFO - PROCESS | 3090 | RSS: Main: 319737856 16:27:00 INFO - PROCESS | 3090 | 16:27:02 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:03 INFO - PROCESS | 3090 | RSS: Main: 321486848 16:27:03 INFO - PROCESS | 3090 | 16:27:05 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:06 INFO - PROCESS | 3090 | RSS: Main: 326041600 16:27:06 INFO - PROCESS | 3090 | 16:27:09 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:10 INFO - PROCESS | 3090 | RSS: Main: 323645440 16:27:10 INFO - PROCESS | 3090 | 16:27:11 INFO - PROCESS | 3090 | Cycle 1(1): loaded http://localhost:49502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49502/tests/kraken/driver.html?testName=ai-astar) 16:27:12 INFO - PROCESS | 3090 | RSS: Main: 370143232 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | __start_tp_report 16:27:12 INFO - PROCESS | 3090 | _x_x_mozilla_page_load 16:27:12 INFO - PROCESS | 3090 | _x_x_mozilla_page_load_details 16:27:12 INFO - PROCESS | 3090 | |i|pagename|runs| 16:27:12 INFO - PROCESS | 3090 | |0;ai-astar;114;107;112;111;110;112;111;112;111;112 16:27:12 INFO - PROCESS | 3090 | |1;audio-beat-detection;161;117;141;147;136;164;160;115;167;117 16:27:12 INFO - PROCESS | 3090 | |2;audio-dft;184;187;183;183;186;181;183;184;185;186 16:27:12 INFO - PROCESS | 3090 | |3;audio-fft;80;75;59;108;57;62;57;59;110;56 16:27:12 INFO - PROCESS | 3090 | |4;audio-oscillator;99;143;126;103;80;77;101;79;77;101 16:27:12 INFO - PROCESS | 3090 | |5;imaging-gaussian-blur;87;86;87;90;88;84;88;86;89;83 16:27:12 INFO - PROCESS | 3090 | |6;imaging-darkroom;93;93;92;93;92;93;93;93;93;93 16:27:12 INFO - PROCESS | 3090 | |7;imaging-desaturate;85;85;86;86;87;84;83;84;82;85 16:27:12 INFO - PROCESS | 3090 | |8;json-parse-financial;57;58;59;57;56;56;58;72;58;60 16:27:12 INFO - PROCESS | 3090 | |9;json-stringify-tinderbox;64;71;68;80;70;71;70;69;73;101 16:27:12 INFO - PROCESS | 3090 | |10;stanford-crypto-aes;92;74;87;86;110;109;84;86;85;85 16:27:12 INFO - PROCESS | 3090 | |11;stanford-crypto-ccm;142;139;137;138;158;147;136;138;180;142 16:27:12 INFO - PROCESS | 3090 | |12;stanford-crypto-pbkdf2;169;226;226;167;170;167;171;167;167;166 16:27:12 INFO - PROCESS | 3090 | |13;stanford-crypto-sha256-iterative;68;67;68;68;65;66;67;65;67;64 16:27:12 INFO - PROCESS | 3090 | __end_tp_report 16:27:12 INFO - PROCESS | 3090 | __start_cc_report 16:27:12 INFO - PROCESS | 3090 | _x_x_mozilla_cycle_collect,1969 16:27:12 INFO - PROCESS | 3090 | __end_cc_report 16:27:12 INFO - PROCESS | 3090 | __startTimestamp1462490832096__endTimestamp 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | ------- Summary: start ------- 16:27:12 INFO - PROCESS | 3090 | Number of tests: 14 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.81 (1.6%) stddev-sans-first:1.62 16:27:12 INFO - PROCESS | 3090 | Values: 114.0 107.0 112.0 111.0 110.0 112.0 111.0 112.0 111.0 112.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:153.50 stddev:20.64 (13.4%) stddev-sans-first:20.77 16:27:12 INFO - PROCESS | 3090 | Values: 161.0 117.0 141.0 147.0 136.0 164.0 160.0 115.0 167.0 117.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.81 (1.0%) stddev-sans-first:1.92 16:27:12 INFO - PROCESS | 3090 | Values: 184.0 187.0 183.0 183.0 186.0 181.0 183.0 184.0 185.0 186.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#3] audio-fft Cycles:10 Average:72.30 Median:59.00 stddev:20.97 (35.5%) stddev-sans-first:22.05 16:27:12 INFO - PROCESS | 3090 | Values: 80.0 75.0 59.0 108.0 57.0 62.0 57.0 59.0 110.0 56.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:77.00 stddev:22.15 (28.8%) stddev-sans-first:23.50 16:27:12 INFO - PROCESS | 3090 | Values: 99.0 143.0 126.0 103.0 80.0 77.0 101.0 79.0 77.0 101.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:2.15 (2.5%) stddev-sans-first:2.28 16:27:12 INFO - PROCESS | 3090 | Values: 87.0 86.0 87.0 90.0 88.0 84.0 88.0 86.0 89.0 83.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 16:27:12 INFO - PROCESS | 3090 | Values: 93.0 93.0 92.0 93.0 92.0 93.0 93.0 93.0 93.0 93.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 16:27:12 INFO - PROCESS | 3090 | Values: 85.0 85.0 86.0 86.0 87.0 84.0 83.0 84.0 82.0 85.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.00 stddev:4.70 (8.1%) stddev-sans-first:4.92 16:27:12 INFO - PROCESS | 3090 | Values: 57.0 58.0 59.0 57.0 56.0 56.0 58.0 72.0 58.0 60.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:70.50 stddev:10.41 (14.8%) stddev-sans-first:10.44 16:27:12 INFO - PROCESS | 3090 | Values: 64.0 71.0 68.0 80.0 70.0 71.0 70.0 69.0 73.0 101.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:85.50 stddev:11.29 (13.2%) stddev-sans-first:11.95 16:27:12 INFO - PROCESS | 3090 | Values: 92.0 74.0 87.0 86.0 110.0 109.0 84.0 86.0 85.0 85.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.00 stddev:13.70 (9.7%) stddev-sans-first:14.47 16:27:12 INFO - PROCESS | 3090 | Values: 142.0 139.0 137.0 138.0 158.0 147.0 136.0 138.0 180.0 142.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:169.50 stddev:24.50 (14.5%) stddev-sans-first:25.69 16:27:12 INFO - PROCESS | 3090 | Values: 169.0 226.0 226.0 167.0 170.0 167.0 171.0 167.0 167.0 166.0 16:27:12 INFO - PROCESS | 3090 | 16:27:12 INFO - PROCESS | 3090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.41 16:27:12 INFO - PROCESS | 3090 | Values: 68.0 67.0 68.0 68.0 65.0 66.0 67.0 65.0 67.0 64.0 16:27:12 INFO - PROCESS | 3090 | -------- Summary: end -------- 16:27:12 INFO - PROCESS | 3090 | 16:27:13 INFO - TEST-INFO | 3090: exit 0 16:27:13 INFO - TEST-OK | kraken | took 59475ms 16:27:13 INFO - SUITE-END | took 1174s 16:27:13 INFO - Completed test suite (00:19:35) 16:27:13 INFO - javascript benchmark 16:27:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.72650187985, 3437.0719905625483, 3456.187795867969, 3457.239407330388, 3508.0352902951686, 5615.101583746601, 5653.462921022501, 5690.345610254822, 5763.798267060653, 5785.0, 5755.136729490579, 5805.3323867755225, 5846.269216347957, 5861.296644402667, 5910.67491287979, 5139.717315547643, 5159.638825282232, 5227.73861306935, 5229.0, 5347.679139251657, 5329.094054010808, 5366.141417373221, 5372.57019438446, 5380.112281473572, 5403.594730395216, 5162.019216348919, 5162.277281180656, 5218.817341393071, 5225.790968361261, 5234.607404444682, 5196.220566914955, 5213.817516386946, 5215.791368345262, 5256.894862102737, 5329.467053294678, 5159.0, 5178.533931946143, 5182.0, 5245.6852588844795, 5266.815661451831, 5548.86127846803, 5627.296587926509, 5702.315722113373, 5723.942760572382, 5785.942140578624, 6247.9687601562155, 6255.155554000243, 6299.338569450233, 6327.8734425311695, 6336.429721325103, 6278.717457714414, 6281.152044473984, 6282.748690052393, 6308.085327627468, 6313.873722525524, 5739.167820666022, 5756.30924289088, 5791.88416231673, 5883.529317654577, 5972.910406343908, 6262.6868656566985, 6287.2140982377205, 6301.369863013753, 6302.275238347649, 6302.464290535264, 6155.2921414037955, 6156.6921653917125, 6161.199044124235, 6170.50635949123, 6186.257649082049, 6159.876802463926, 6210.130581718563, 6281.8743625127245, 6295.96852015737, 6303.180586523723, 6228.22147231596, 6308.085327627468, 6314.116023756677, 6314.71583778731, 6329.588576742497, 6228.28374736902, 6316.8420789479715, 6328.0, 6343.5876668016435, 6348.587341822767, 4894.926576101361, 4928.531789479994, 4956.008798240367, 4997.975010124999, 5007.524285192901, 4479.955200448019, 4516.570925762047, 4524.954750452519, 4526.864194074183, 4540.886477838015, 5786.334571524244, 5789.305283366023, 5791.913121303184, 5814.76740930358, 5814.854628634233, 6019.638821670714, 6174.969125154345, 6247.156633854463, 6257.4681152102585, 6271.937280627135, 5649.858753531194, 5769.105788602689, 5836.095405212199, 5849.678267695318, 5854.912176317359, 4782.210935195723, 5461.2354270402175, 5490.423505531861, 5500.28496295487, 5505.917411238835, 6314.116023756677, 6330.525210609223, 6356.904646430307, 6388.776392826228, 6495.642739649365, 6237.781677641261, 6277.780277690259, 6284.780032698834, 6294.8426289341305, 6302.684865756785, 6224.688765561795, 6455.386738259858, 6467.126937863328, 6474.449671777763, 6480.222373315232, 6138.51101655979, 6147.139400483847, 6191.907121393093, 6265.843353916189, 6268.216472940882, 6257.874842503215, 6273.71768270438, 6280.214973128359, 6282.3089460158435, 6290.779822706183, 6013.939860601338, 6102.359252278625, 6149.846253843511, 6151.477124444294, 6172.845678858064, 6124.173236613178, 6163.445289923929, 6178.382161783786, 6182.969085154546, 6185.319614842274, 5860.765569377348, 6020.247469066367, 6037.577369584263, 6057.606255593372, 6094.695265236632, 6014.278286605635, 6123.326434092157, 6127.3566275540425, 6138.07928810682, 6164.106204600397, 6079.392060794062, 6095.420935011167, 6102.847428814315, 6119.898418284752, 6134.6625935573975], "value": 5757.207808372643, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.03629975996427, 502.9874253143672, 503.5769953239279, 513.8484147176582, 555.2864569028794, 30876.610552525133, 31463.0, 42879.35680964784, 43713.34429983553, 43923.56076439234, 42425.575744242546, 45059.0, 45214.77392613041, 45231.77384113083, 45246.0950780985, 9614.423134611929, 9793.461359625218, 9808.31341806074, 9809.50952452378, 9814.165795907356, 9571.569279382444, 9683.612655493771, 9686.612535498572, 9690.418574885494, 9700.660476883311, 8264.421490495668, 9730.756731081708, 9732.805343893118, 9740.659076932308, 9754.853677194847, 9693.273004524688, 9706.75733106678, 9708.077732615391, 9710.563024663907, 9718.271129665303, 8184.6316915738935, 9594.280428967786, 9667.226621870233, 9669.70990870275, 9676.709698708979, 41435.37846932298, 41895.58104418947, 41903.0, 41949.370759438636, 41987.0, 2640.7755340796057, 3201.855916483764, 3256.5766450361302, 3261.4129456697783, 3439.5725773803842, 29073.709262907523, 29634.55548166779, 30283.545746813594, 30289.242768930733, 30735.231619209477, 2532.4935012997475, 2633.6436735081447, 2765.7372549607753, 2772.5979732938613, 2893.7250961158657, 480847.0, 481645.18354816356, 482661.0, 485584.99999999645, 488338.0, 35459.82270088633, 36449.453258201145, 65034.0, 65660.0, 65790.67104664446, 37706.43440348397, 37770.0, 37898.43152352717, 37937.24125517474, 37979.62020379761, 15451.072935623899, 15640.0, 15662.37350505967, 15662.82528810321, 15728.370865165494, 12743.235405875677, 12775.23348599087, 12813.0, 12813.487460501476, 12823.294718790556, 8269.04905935813, 8273.379496537784, 8293.58532073406, 8348.874766878502, 8361.707340243183, 3444.190615205425, 3469.5366289934427, 3478.286951175003, 3486.4770284457027, 3495.1262184453885, 998.4009594243541, 1054.488573042074, 1103.784761971424, 1134.7446824464594, 1176.8705442401329, 24783.25650230496, 29296.56055159174, 29551.817927283097, 29787.851060744557, 30612.0, 916.3722849847876, 1016.6492560066765, 1178.1046404732465, 1190.220405634311, 1248.0452453872795, 15344.616384590474, 15434.84565154334, 15465.536033918776, 15475.916685831884, 15928.92035539838, 649003.0, 663222.0, 671088.0, 672342.0, 672940.0, 60789.392106079256, 61164.0, 61372.38627613756, 61437.078443823375, 61451.07823382653, 1332.1474256475863, 1472.9189894555689, 1489.3670190169134, 1513.954581362561, 1525.6185953511622, 25274.620880687173, 28133.175501596324, 29019.85490072536, 29402.264943376587, 32099.71601136022, 50605.98788024292, 50942.0, 51308.23037654364, 51393.20123795649, 51690.74154629353, 513605.0, 514937.0, 516049.0, 516762.0, 518073.0, 23398.415039624146, 26042.34894127662, 26860.05989790348, 27043.86478067597, 27176.1847144586, 46871.76564117294, 47004.764976176266, 47479.25207479363, 47987.0, 48349.75825120852, 37215.0, 37777.24445511129, 38222.044448887886, 38805.80597096997, 39062.2187556253, 37877.0, 37901.431478527295, 38202.617973819906, 38902.80548597239, 39063.41404878986, 35007.124821878635, 37472.0, 37877.81061094677, 38912.41631375475, 38932.6106738929, 31008.844955775076, 33527.82652607147, 33704.0, 33897.830510847285, 33956.64173433035, 23717.0, 24237.151699690425, 24541.631875521525, 24900.501989959736, 25349.493010140064], "value": 18698.306034085013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3714596623639, 398.76672146794124, 398.96409323160907, 399.95400528939183, 425.9467566554181, 20625.27811526597, 20690.482737931557, 21798.346049618496, 21977.890110549444, 22049.338519844412, 12124.636260912164, 12447.004239660828, 17432.215550300236, 21279.57440851182, 21294.57410851782, 5371.113766228577, 5559.054960656698, 5860.882782344372, 6227.532935029868, 6235.906461403082, 6178.598391104564, 6198.380161983788, 6221.906671399933, 6225.252969643627, 6241.781537646183, 6406.423421892029, 6862.656867156647, 6863.4166095881665, 6883.931160688404, 6891.965540172292, 6212.689365531751, 6233.657148856811, 6687.832804179886, 6807.0, 6908.032875397448, 5874.118882167666, 6047.939520604826, 6071.453569178795, 6072.5445591580365, 6075.513958883279, 24568.631470527955, 25419.61870571943, 25975.090871819586, 25980.830862611227, 26724.931002759866, 2092.3618296419586, 2093.058123844276, 2157.234181865431, 2211.1929145861645, 2618.2276228512633, 9828.705138845846, 9979.10188083076, 10143.442110683909, 10184.541695623715, 10455.790884182274, 1492.9104253744702, 1729.1267909705643, 1792.050213386907, 1796.6765982123213, 1874.4189301316635, 128227.35886320508, 128324.35837820845, 128743.0, 129396.0, 130737.0, 11527.48126334317, 11743.41282935867, 11797.705057373463, 11807.940960295315, 11979.700507487209, 15481.225938703019, 15599.454019109276, 15605.297761600756, 15609.219539023003, 15628.140452275007, 8841.469511829311, 8864.468131912106, 8953.015168331478, 8954.776130596787, 9058.954705226432, 7873.842523149505, 8075.838483230303, 8768.824623507622, 8800.427972181787, 8920.464772113693, 4686.7656617169005, 4695.272232803921, 4710.434747830213, 4718.245080787057, 4733.763311834395, 1759.357834390464, 1848.7798053284766, 1915.9233630654617, 1974.299123811055, 1977.1103003648416, 777.8249893773968, 826.9415148609789, 925.1858364639209, 952.7808604021114, 959.3572306554626, 17527.900401765735, 20894.686579701316, 20997.0, 21016.579668406546, 21080.78919210788, 989.7575094101848, 994.8259054665405, 1005.6429967361628, 1035.2649618770606, 1037.5953378182514, 9755.563626593996, 10936.434031322235, 10955.4522273886, 10979.341239525655, 10991.395473249047, 561595.0, 585922.0, 595383.0, 595695.0, 599467.0026649839, 82010.58994704988, 117509.99999999828, 121705.0, 138824.8013727846, 145344.0, 961.9855702164473, 967.777411195415, 980.1081016275298, 999.5551979369111, 999.6251405722854, 18132.002739849435, 18835.340763073225, 18900.527486812938, 19020.635408101734, 19052.904735476233, 42187.0, 51512.535841493605, 51572.48427515677, 52442.475575245284, 53664.73167634137, 67052.3294767046, 67904.2281406086, 69144.0, 69651.65174174096, 72031.0, 8113.18868113184, 8149.837003259783, 8169.856220129305, 8363.414560980673, 8382.455140415854, 11418.31490110596, 11993.940030299793, 12528.0, 12947.223166609656, 12975.416106275052, 9951.303408761607, 10140.645077422254, 10807.513661885077, 10910.509027093642, 11229.66311010671, 8664.093899342135, 10763.3541987481, 10901.182411319342, 11043.0, 11068.169887258327, 10835.458227088771, 11084.445777711244, 11469.369184694922, 11476.483558239732, 11521.769564608829, 8061.83876322482, 8155.469894456842, 8186.83626327482, 8262.586870656323, 8451.661933522837, 10558.155347572023, 10993.120550355792, 11221.60724374643, 11281.887181128412, 11301.830472542753], "value": 9611.311744073259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.6277767780373, 1584.112896777804, 1598.001249219238, 1846.4091490722965, 1955.941321760347, 7755.991721076266, 7893.960530197348, 8586.398952073358, 8872.20150186483, 8889.28885689144, 8673.262772664331, 8927.41971771836, 8931.910680893188, 8944.508052057134, 8951.910480895189, 2477.2444404456633, 2520.143151328548, 2522.583773677341, 2523.5836087045614, 2523.974760252392, 2459.532688789124, 2505.549001179787, 2515.0, 2516.5721827289312, 2517.2699917024133, 2473.9628905566433, 2490.1657944588583, 2510.79913606911, 2513.1204078572537, 2514.245726282117, 1977.812107849752, 1991.4523506035812, 2392.760723927602, 2426.4540478392396, 2443.2914454808083, 2438.296475363359, 2473.2085732565406, 2473.4558397152596, 2478.5538603051446, 2487.2786891801356, 7548.73579424723, 8446.197611226924, 8758.211760941545, 8830.779230519223, 8839.02770695223, 5400.648957817729, 5530.778768849241, 5561.360443549003, 5572.916406253868, 5577.972110139423, 3523.71810255179, 3653.0319465341704, 3728.4780130781714, 3729.5710993235584, 3758.0980564664555, 909.8771665825095, 1054.3410368519676, 1063.1760385701143, 1065.3607835298758, 1065.55779351569, 11850.992665623433, 11990.520379184822, 11994.040476761838, 12008.099392545593, 12010.879891201152, 4621.23749581322, 4679.742614156186, 4792.305115758196, 4807.18277892759, 4813.614910807127, 9370.0, 9376.343655944154, 9384.95307523458, 9396.342256042011, 9416.764580885532, 5422.8915421691345, 5455.754491047913, 5456.045192091368, 5464.0, 5465.945340546544, 4173.499180098408, 4502.482214545304, 4698.906021879543, 4923.359963204832, 5035.647504674711, 3871.4192871069563, 3907.9609203908167, 3931.1548017176447, 3970.2059588082498, 4002.478438583732, 1211.2671833540758, 1226.760781647588, 1229.8155276708565, 1238.9566365177175, 1242.0932719115096, 840.6805413942785, 919.2921450483224, 921.0697195832257, 927.3693888155984, 941.7033634405141, 5950.761969521171, 6062.120992456069, 6148.631082135086, 6212.844678883064, 6325.399087086719, 958.6453012385323, 981.6956743409565, 987.0820137272262, 1005.7787286796893, 1034.1209971524145, 3370.898873033813, 3916.472575695481, 3976.781277029791, 4007.338789099766, 4083.9795801020805, 10233.48832558369, 10427.478626068667, 10677.09244714208, 10716.196285278635, 10721.98141176587, 10582.994615511514, 10640.733981650366, 10751.086157676686, 10769.83845242322, 10789.298695584763, 8013.599320033975, 8269.0, 8279.047909490366, 8382.958085209657, 8386.371022173484, 5883.441073098049, 5927.9703601481715, 6003.519718422603, 6016.368281330572, 6067.666278354556, 9985.301028927905, 10258.794824103625, 10297.485125743533, 10303.278770486293, 10307.123894469054, 9957.651482198089, 10109.545070471993, 10385.013423724735, 10393.740156496147, 10504.789904202025, 6377.553571249968, 6720.731170753115, 6784.08414863987, 7087.7164913402885, 7089.0, 8438.53588052663, 8489.278411335106, 8595.18345757152, 8599.355048371272, 8603.053664096818, 7098.858022839618, 7533.434992375484, 7628.80927976805, 7641.847163056819, 7795.41534384912, 7372.63136843145, 7397.408207343292, 7474.775756727089, 7630.236976302325, 7632.923670763222, 7083.574985500886, 7147.82130446743, 7161.677724502306, 7166.605836678824, 7168.67740951648, 4310.181065597527, 4817.723303324692, 4836.0, 5087.92368114486, 5106.46382129871, 5031.295618613471, 5090.134677104975, 5091.1854103343285, 5162.561182299547, 5313.707746074003], "value": 4634.549410472838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.6692555502834, 319.85926192475307, 323.5001922030462, 326.8872239077519, 332.0, 4144.792760361981, 4549.795259213335, 5159.587233021359, 5229.7385130743505, 5232.529072383485, 4368.907773056736, 5182.341650671787, 5192.3249977502965, 5202.661826981243, 5215.843524694255, 3766.2090960898245, 3832.8466861325514, 3897.3569361055534, 3973.284808734427, 4050.9797451012705, 3808.257389808988, 3926.685865130797, 3951.1505026419313, 3986.8869499165344, 4041.8376168749724, 3654.6528079832374, 3804.353259945802, 3984.8007599620046, 3988.9002774930714, 3990.7805070721097, 3360.512725654766, 3525.770824896399, 3774.4904437900805, 3841.654251117385, 3927.5286965564173, 2963.6739958604535, 3159.699828516287, 3195.2745517420567, 3248.0418276608457, 3499.772514786531, 4549.134854709553, 4635.4210865235245, 4989.800407983676, 5018.77415516299, 5027.235020738579, 3814.6757525610356, 4550.158220729142, 4578.587927086578, 4591.357209990604, 4605.355250264965, 4999.975000124976, 5325.201219817059, 5406.783728650849, 5412.864678383072, 5413.350397952231, 3089.845507724605, 3418.4017796885446, 3819.140693344003, 3840.635139661728, 3860.0, 4329.913401731979, 5686.346070201938, 5730.942690573124, 5733.426657334275, 5739.494496820018, 3329.334133173375, 3628.258435950758, 3902.083010492532, 3939.428782826474, 3962.0, 3826.2972977025515, 3952.1898010907694, 3956.248312820555, 3960.603939606074, 3972.1857019310974, 3535.292941411728, 4196.538380778112, 4530.139273538083, 4543.659225558096, 4574.817007319736, 4681.976590117028, 5078.949210507922, 5159.406668233201, 5467.398586155519, 5528.419515950848, 1094.5348227003492, 1183.5088438298183, 1237.9257244565174, 1246.426643743888, 1263.6082814327588, 831.6216121664628, 840.2060053249743, 848.7538613801928, 865.2774932931073, 875.8905136857893, 4629.583337499574, 4884.682495637843, 4962.950370496249, 5076.593872490192, 5117.948820511747, 4881.389826271716, 5144.0, 5558.694271815089, 5578.386377498472, 5591.049521581341, 4371.103923695635, 4486.327050942385, 4900.26496025599, 5073.594112470993, 5076.111680455905, 2512.459821138464, 2811.493931092382, 2828.5474324108045, 2842.7349829326163, 2843.45974264889, 4623.237165867661, 5033.899322013613, 5373.650712703662, 5561.777528898799, 5576.665400076008, 5191.610629202825, 5360.785568577291, 5405.21624364465, 5483.080921677381, 5532.280803495601, 4840.878978025577, 4928.0, 4954.6646684151365, 5484.232207490954, 5649.802256920988, 4679.976600116977, 4775.373544550553, 4791.305260737243, 4840.515948405272, 4973.701577905337, 4179.9582004179565, 5259.105951988247, 5279.656822306538, 5298.523132918056, 5330.200469929541, 4950.900981980412, 4959.0, 5362.651427657346, 5604.915926261191, 5646.915296270641, 3358.580177477815, 3433.6738009889023, 3593.604703482667, 3610.598951697197, 3614.2109655720587, 4731.053789242096, 4819.638527110551, 4902.3872015998, 5269.417985187307, 5320.0955837506945, 4769.809207631656, 5061.39263288393, 5156.922646160236, 5168.664036837594, 5170.974145129401, 4643.421236779511, 4828.517148285144, 4920.277902734015, 5037.974810125926, 5114.514121158484, 4294.39581346346, 4837.661363704507, 5000.613301278063, 5007.697998520338, 5028.058585727391, 5175.611829112756, 5208.348956380452, 5278.656887302313, 5328.868452618984, 5453.7818487260065, 5316.272211531191, 5322.0154271459905, 5326.786928522971, 5331.893362132658, 5345.4654534546235], "value": 3885.5230514010345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3062993777529, 665.9334066593339, 723.7901008707473, 733.3729661139722, 799.420420195358, 14375.0, 14804.851951480481, 15072.77390839137, 15093.320800563974, 15655.608609784762, 12371.443285052172, 13988.58034258974, 14294.428222871073, 14426.783598246035, 14518.201498917555, 746.9663865126055, 765.1506827421557, 912.5026860361086, 916.5737931861667, 945.6595625574788, 936.4334577580534, 942.9387089839173, 943.6178347769164, 943.7451887990238, 945.754103932979, 1005.1305620638132, 1006.8892421833592, 1009.0363702663975, 1009.9394036357842, 1011.357787804742, 776.1036003416064, 956.516958935733, 982.641335912394, 985.8324084905584, 988.9653862114827, 742.3912391838694, 742.524784138152, 744.270614797496, 744.9515781474241, 747.9887801682979, 14602.12387256768, 14660.266986650624, 14670.926645366704, 14692.191929443876, 14698.33857476416, 12244.326562039085, 12285.754284914252, 12343.580488243877, 12394.814077788751, 12602.432890519856, 10588.523516441779, 10830.187735919837, 10996.670099897015, 11011.889881101166, 11264.887351126466, 3976.9858686034877, 3993.6605388542007, 4001.0, 4005.2590270799997, 4011.7793521356316, 74758.62620686916, 76113.0, 78209.82685259725, 78224.21775782226, 78892.42215155723, 9577.521123943776, 9607.615695372248, 9629.374090684083, 9847.55685994132, 9862.950685246527, 19874.490522093514, 21158.78841211599, 21180.78819211819, 21186.258480953093, 21243.893780531307, 7474.289942455458, 7552.358049565739, 7704.6918123274445, 7772.18392068836, 7776.144624091346, 4056.513218413809, 4140.585941405896, 4142.5857414258935, 4186.623203911602, 4420.469543654718, 3585.731070169748, 3637.0543658648944, 3647.5805282392867, 3684.8341824617955, 3691.483192353073, 657.050561937995, 657.8750037492861, 665.8583609946128, 673.7978606418055, 677.0893148714971, 475.73358919005466, 509.26157072245394, 545.1250742558216, 570.0594019867252, 594.6432140715536, 8041.7989550260545, 8076.446681821993, 8226.465279756796, 8253.380996425292, 8440.40917135807, 471.36130543114274, 578.288704892984, 602.3645054467579, 605.4702135631322, 606.5784279925409, 3886.5724770275247, 3942.8225729842225, 4014.0566966762785, 4079.583192475171, 4212.789360531961, 77173.22826771773, 79822.60088699519, 79885.20114798893, 92376.53811731032, 94725.05274947162, 71894.0, 76909.61545192238, 76911.61544192243, 78505.0, 79314.0, 66219.0, 69633.65183174051, 70606.64696676689, 71141.2885871145, 71629.56740865154, 8382.916170838214, 8422.578871056545, 8424.29652087618, 8521.91478085236, 8594.65621375138, 42339.364909525764, 44350.01699694086, 45782.31326530172, 46198.53801461942, 46754.59736207919, 60265.8906938255, 63872.0, 63947.360526396, 64287.0, 64372.356276438506, 9509.524523773922, 11297.830532542182, 11370.147238956946, 11387.601433949772, 11569.710757231136, 11875.940620296844, 11912.940435297767, 11921.403929803302, 12066.155369124077, 13333.20000799955, 11702.648920532398, 11850.940745296219, 12207.267563946192, 12256.0, 12567.748645027232, 11780.82328765052, 11830.881691182978, 12041.157119001937, 12183.0, 12290.385480725748, 11500.424978751196, 11512.19414640967, 11640.952314291755, 11722.355270460206, 11884.762304753684, 9567.186789123003, 9686.418814871131, 9855.655052073143, 9937.403755774676, 10101.09014903496, 8954.910450895668, 9083.818323633359, 9452.858207126761, 9729.562169702522, 9938.155256802964], "value": 6939.228273648919, "unit": "score"}], "name": "dromaeo_css", "value": 7111.072056650724, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 112.0, 111.0, 110.0, 112.0, 111.0, 112.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 117.0, 141.0, 147.0, 136.0, 164.0, 160.0, 115.0, 167.0, 117.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 183.0, 183.0, 186.0, 181.0, 183.0, 184.0, 185.0, 186.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 59.0, 108.0, 57.0, 62.0, 57.0, 59.0, 110.0, 56.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 143.0, 126.0, 103.0, 80.0, 77.0, 101.0, 79.0, 77.0, 101.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 90.0, 88.0, 84.0, 88.0, 86.0, 89.0, 83.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 86.0, 87.0, 84.0, 83.0, 84.0, 82.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 57.0, 56.0, 56.0, 58.0, 72.0, 58.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 68.0, 80.0, 70.0, 71.0, 70.0, 69.0, 73.0, 101.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 74.0, 87.0, 86.0, 110.0, 109.0, 84.0, 86.0, 85.0, 85.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 137.0, 138.0, 158.0, 147.0, 136.0, 138.0, 180.0, 142.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 226.0, 226.0, 167.0, 170.0, 167.0, 171.0, 167.0, 167.0, 166.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 65.0, 66.0, 67.0, 65.0, 67.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1487.5, "alertThreshold": 2.0}]} 16:27:13 INFO - Return code: 0 16:27:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:27:13 ERROR - # TBPL SUCCESS # 16:27:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:27:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:27:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:27:13 INFO - 2016-05-05 16:27:13.427 screenresolution[3094:46529] starting screenresolution argv=screenresolution get 16:27:13 INFO - 2016-05-05 16:27:13.430 screenresolution[3094:46529] Display 0: 1600x1200x32@60 16:27:13 INFO - 2016-05-05 16:27:13.436 screenresolution[3095:46532] starting screenresolution argv=screenresolution list 16:27:13 INFO - Available Modes on Display 0 16:27:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:27:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:27:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:27:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:27:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:27:13 INFO - Intel Iris: 16:27:13 INFO - Chipset Model: Intel Iris 16:27:13 INFO - Type: GPU 16:27:13 INFO - Bus: Built-In 16:27:13 INFO - VRAM (Dynamic, Max): 1536 MB 16:27:13 INFO - Vendor: Intel (0x8086) 16:27:13 INFO - Device ID: 0x0a2e 16:27:13 INFO - Revision ID: 0x0009 16:27:13 INFO - Displays: 16:27:13 INFO - Display: 16:27:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:27:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:27:13 INFO - Display Serial Number: 1600x1200 60 16:27:13 INFO - Main Display: Yes 16:27:13 INFO - Mirror: Off 16:27:13 INFO - Online: Yes 16:27:13 INFO - Rotation: Supported 16:27:13 INFO - Return code: 0 16:27:13 INFO - Running post-action listener: _resource_record_post_action 16:27:13 INFO - Running post-run listener: _resource_record_post_run 16:27:14 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 487424; Write bytes: 694467072; Read time: 4; Write time: 2098 16:27:14 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397287936; Write bytes: 400416768; Read time: 29621; Write time: 750 16:27:14 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 487424; Write bytes: 293202432; Read time: 4; Write time: 1345 16:27:14 INFO - Running post-run listener: _upload_blobber_files 16:27:14 INFO - Blob upload gear active. 16:27:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:14 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 16:27:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:27:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:15 INFO - (blobuploader) - INFO - Done attempting. 16:27:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:27:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:27:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:16 INFO - (blobuploader) - INFO - Done attempting. 16:27:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:16 INFO - Return code: 0 16:27:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d3bc8a2920ed67e04a1fc4201fb575e066a95b9104a6489920bb8a7074292796ebc9c554b7718404ab1a87abd69792ea58cde9b5850bb5bded0b0cd78ffa14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbd0c61f022b632d5aa3f779634f1e59bdff6e1ab646bbcc7f2931746f4c799645350183f72d826008f07e58635ab221308f1b8b3dc64b861ed16112dad388b"} 16:27:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:16 INFO - Contents: 16:27:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d3bc8a2920ed67e04a1fc4201fb575e066a95b9104a6489920bb8a7074292796ebc9c554b7718404ab1a87abd69792ea58cde9b5850bb5bded0b0cd78ffa14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbd0c61f022b632d5aa3f779634f1e59bdff6e1ab646bbcc7f2931746f4c799645350183f72d826008f07e58635ab221308f1b8b3dc64b861ed16112dad388b"} 16:27:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:16 INFO - Copying logs to upload dir... 16:27:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.635393 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-05-05 16:27:16.928431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 16:27:16.932637) ========= 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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d3bc8a2920ed67e04a1fc4201fb575e066a95b9104a6489920bb8a7074292796ebc9c554b7718404ab1a87abd69792ea58cde9b5850bb5bded0b0cd78ffa14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbd0c61f022b632d5aa3f779634f1e59bdff6e1ab646bbcc7f2931746f4c799645350183f72d826008f07e58635ab221308f1b8b3dc64b861ed16112dad388b"} build_url:https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64d3bc8a2920ed67e04a1fc4201fb575e066a95b9104a6489920bb8a7074292796ebc9c554b7718404ab1a87abd69792ea58cde9b5850bb5bded0b0cd78ffa14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddbd0c61f022b632d5aa3f779634f1e59bdff6e1ab646bbcc7f2931746f4c799645350183f72d826008f07e58635ab221308f1b8b3dc64b861ed16112dad388b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 16:27:16.960078) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:27:16.963392) ========= 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.58Jaz1nvkp/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.cVgnwduzmQ/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005334 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:27:17.011676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 16:27:17.011951) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 16:27:17.012227) ========= ========= Total master_lag: 0.18 =========