builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0036 starttime: 1461640091.37 results: success (0) buildid: 20160425181356 builduid: 5ae703220f69444a904ff843c2df0b7b revision: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:11.367243) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:11.367685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 11 secs) (at 2016-04-25 20:08:11.367979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 11 secs) (at 2016-04-25 20:08:23.176918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-25 20:08:23.177228) ========= 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.OLlehdlwOY/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.t4OVTqiMMC/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 20:08:23-- 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% 148M=0s 2016-04-25 20:08:23 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.597847 ========= master_lag: 2.85 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-25 20:08:26.622224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:26.622556) ========= 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.OLlehdlwOY/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.t4OVTqiMMC/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.022856 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:26.670010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:26.670367) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 --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 f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OLlehdlwOY/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.t4OVTqiMMC/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 20:08:26,748 truncating revision to first 12 chars 2016-04-25 20:08:26,748 Setting DEBUG logging. 2016-04-25 20:08:26,749 attempt 1/10 2016-04-25 20:08:26,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f4fd92a0496f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 20:08:27,473 unpacking tar archive at: fx-team-f4fd92a0496f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.971312 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:27.664853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:27.665184) ========= script_repo_revision: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:27.665577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:27.665858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 20:08:27.844682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 20:08:27.845089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OLlehdlwOY/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.t4OVTqiMMC/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:08:28 INFO - MultiFileLogger online at 20160425 20:08:28 in /builds/slave/test 20:08:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:08:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:08:28 INFO - {'append_to_log': False, 20:08:28 INFO - 'base_work_dir': '/builds/slave/test', 20:08:28 INFO - 'blob_upload_branch': 'Fx-Team', 20:08:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:08:28 INFO - 'branch': 'Fx-Team', 20:08:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:28 INFO - 'config_files': ('talos/mac_config.py',), 20:08:28 INFO - 'default_actions': ('clobber', 20:08:28 INFO - 'read-buildbot-config', 20:08:28 INFO - 'download-and-extract', 20:08:28 INFO - 'populate-webroot', 20:08:28 INFO - 'create-virtualenv', 20:08:28 INFO - 'install', 20:08:28 INFO - 'run-tests'), 20:08:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:28 INFO - 'download_minidump_stackwalk': True, 20:08:28 INFO - 'download_symbols': 'ondemand', 20:08:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:28 INFO - 'installer_path': 'installer.exe', 20:08:28 INFO - 'log_level': 'info', 20:08:28 INFO - 'log_name': 'talos', 20:08:28 INFO - 'log_to_console': True, 20:08:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:08:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:08:28 INFO - 'opt_config_files': (), 20:08:28 INFO - 'pip_index': False, 20:08:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:28 INFO - 'cmd': ('bash', 20:08:28 INFO - '-c', 20:08:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:28 INFO - 'enabled': True, 20:08:28 INFO - 'halt_on_failure': False, 20:08:28 INFO - 'name': 'check_screen_resolution'},), 20:08:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:08:28 INFO - 'cmd': ('bash', 20:08:28 INFO - '-c', 20:08:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:08:28 INFO - 'enabled': True, 20:08:28 INFO - 'halt_on_failure': False, 20:08:28 INFO - 'name': 'check_screen_resolution'},), 20:08:28 INFO - 'run_cmd_checks_enabled': True, 20:08:28 INFO - 'sps_profile': False, 20:08:28 INFO - 'sps_profile_interval': 0, 20:08:28 INFO - 'suite': 'dromaeojs-e10s', 20:08:28 INFO - 'system_bits': '32', 20:08:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:28 INFO - 'title': 't-yosemite-r7-0036', 20:08:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:28 INFO - 'use_talos_json': True, 20:08:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:08:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:28 INFO - 'work_dir': 'build'} 20:08:28 INFO - ##### 20:08:28 INFO - ##### Running clobber step. 20:08:28 INFO - ##### 20:08:28 INFO - Running pre-action listener: _resource_record_pre_action 20:08:28 INFO - Running main action method: clobber 20:08:28 INFO - rmtree: /builds/slave/test/build 20:08:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:08:28 INFO - Running post-action listener: _resource_record_post_action 20:08:28 INFO - ##### 20:08:28 INFO - ##### Running read-buildbot-config step. 20:08:28 INFO - ##### 20:08:28 INFO - Running pre-action listener: _resource_record_pre_action 20:08:28 INFO - Running main action method: read_buildbot_config 20:08:28 INFO - Using buildbot properties: 20:08:28 INFO - { 20:08:28 INFO - "project": "", 20:08:28 INFO - "product": "firefox", 20:08:28 INFO - "script_repo_revision": "production", 20:08:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:08:28 INFO - "repository": "", 20:08:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:08:28 INFO - "buildid": "20160425181356", 20:08:28 INFO - "pgo_build": "False", 20:08:28 INFO - "basedir": "/builds/slave/test", 20:08:28 INFO - "buildnumber": 638, 20:08:28 INFO - "slavename": "t-yosemite-r7-0036", 20:08:28 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:08:28 INFO - "platform": "yosemite_r7", 20:08:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 20:08:28 INFO - "branch": "fx-team", 20:08:28 INFO - "repo_path": "integration/fx-team", 20:08:28 INFO - "revision": "f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3", 20:08:28 INFO - "stage_platform": "macosx64", 20:08:28 INFO - "builduid": "5ae703220f69444a904ff843c2df0b7b", 20:08:28 INFO - "slavebuilddir": "test" 20:08:28 INFO - } 20:08:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 20:08:28 INFO - Running post-action listener: _resource_record_post_action 20:08:28 INFO - ##### 20:08:28 INFO - ##### Running download-and-extract step. 20:08:28 INFO - ##### 20:08:28 INFO - Running pre-action listener: _resource_record_pre_action 20:08:28 INFO - Running main action method: download_and_extract 20:08:28 INFO - mkdir: /builds/slave/test/build/tests 20:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:28 INFO - https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:30 INFO - Downloaded 1199 bytes. 20:08:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:08:30 INFO - Using the following test package requirements: 20:08:30 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:08:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 20:08:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 20:08:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'jsshell-mac.zip'], 20:08:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 20:08:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:08:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 20:08:30 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 20:08:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 20:08:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:08:30 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 20:08:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:30 INFO - https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:31 INFO - Downloaded 18113194 bytes. 20:08:31 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'] 20:08:31 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 20:08:34 INFO - Return code: 0 20:08:34 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 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:34 INFO - https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:37 INFO - Downloaded 18113194 bytes. 20:08:37 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'] 20:08:37 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 20:08:41 INFO - Return code: 0 20:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:08:41 INFO - https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:42 INFO - Downloaded 10840145 bytes. 20:08:42 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'] 20:08:42 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 20:08:42 INFO - Return code: 0 20:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:42 INFO - https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 20:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/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 20:08:45 INFO - Downloaded 110097629 bytes. 20:08:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:08:45 INFO - mkdir: /builds/slave/test/properties 20:08:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:45 INFO - Contents: 20:08:45 INFO - build_url:https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:08:46 INFO - Running post-action listener: _resource_record_post_action 20:08:46 INFO - Running post-action listener: set_extra_try_arguments 20:08:46 INFO - ##### 20:08:46 INFO - ##### Running populate-webroot step. 20:08:46 INFO - ##### 20:08:46 INFO - Running pre-action listener: _resource_record_pre_action 20:08:46 INFO - Running main action method: populate_webroot 20:08:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:46 INFO - '--tppagecycles', 20:08:46 INFO - '7'], 20:08:46 INFO - 'tests': ['tsvgm']}}, 20:08:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['damp', 'tps']}, 20:08:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'tests': ['damp', 'tps']}, 20:08:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['dromaeo_dom']}, 20:08:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['a11yr', 20:08:46 INFO - 'ts_paint', 20:08:46 INFO - 'tpaint', 20:08:46 INFO - 'sessionrestore', 20:08:46 INFO - 'sessionrestore_no_auto_restore', 20:08:46 INFO - 'tabpaint']}, 20:08:46 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:46 INFO - 'ts_paint', 20:08:46 INFO - 'tpaint', 20:08:46 INFO - 'sessionrestore', 20:08:46 INFO - 'sessionrestore_no_auto_restore', 20:08:46 INFO - 'tabpaint']}, 20:08:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:46 INFO - 'ts_paint', 20:08:46 INFO - 'tpaint', 20:08:46 INFO - 'sessionrestore', 20:08:46 INFO - 'sessionrestore_no_auto_restore', 20:08:46 INFO - 'tabpaint']}, 20:08:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:46 INFO - 'ts_paint', 20:08:46 INFO - 'tpaint', 20:08:46 INFO - 'sessionrestore', 20:08:46 INFO - 'sessionrestore_no_auto_restore', 20:08:46 INFO - 'tabpaint']}, 20:08:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['a11yr', 20:08:46 INFO - 'ts_paint', 20:08:46 INFO - 'tpaint', 20:08:46 INFO - 'sessionrestore', 20:08:46 INFO - 'sessionrestore_no_auto_restore', 20:08:46 INFO - 'tabpaint']}, 20:08:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['a11yr', 20:08:46 INFO - 'ts_paint', 20:08:46 INFO - 'tpaint', 20:08:46 INFO - 'sessionrestore', 20:08:46 INFO - 'sessionrestore_no_auto_restore', 20:08:46 INFO - 'tabpaint']}, 20:08:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['tsvgx', 20:08:46 INFO - 'tsvgr_opacity', 20:08:46 INFO - 'tart', 20:08:46 INFO - 'tscrollx', 20:08:46 INFO - 'cart']}, 20:08:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:46 INFO - 'tsvgr_opacity', 20:08:46 INFO - 'tart', 20:08:46 INFO - 'tscrollx', 20:08:46 INFO - 'cart']}, 20:08:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'talos_options': ['--disable-e10s'], 20:08:46 INFO - 'tests': ['tp5o']}, 20:08:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'tests': ['tp5o']}, 20:08:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'talos_options': ['--disable-e10s', 20:08:46 INFO - '--xperf_path', 20:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:46 INFO - 'tests': ['tp5n']}, 20:08:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:46 INFO - 'talos_options': ['--xperf_path', 20:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:46 INFO - 'tests': ['tp5n']}}, 20:08:46 INFO - 'talos.zip': {'path': '', 20:08:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:46 INFO - Running post-action listener: _resource_record_post_action 20:08:46 INFO - ##### 20:08:46 INFO - ##### Running create-virtualenv step. 20:08:46 INFO - ##### 20:08:46 INFO - Running pre-action listener: _resource_record_pre_action 20:08:46 INFO - Running main action method: create_virtualenv 20:08:46 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:46 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 20:08:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:46 INFO - Using real prefix '/tools/python27' 20:08:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:50 INFO - Installing pip.................done. 20:08:50 INFO - Return code: 0 20:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:50 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')]} 20:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:50 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')]} 20:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:50 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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:08:50 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 20:08:50 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 20:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:50 INFO - 'HOME': '/Users/cltbld', 20:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:50 INFO - 'LOGNAME': 'cltbld', 20:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:50 INFO - 'MOZ_NO_REMOTE': '1', 20:08:50 INFO - 'NO_EM_RESTART': '1', 20:08:50 INFO - 'PAGER': '/bin/cat', 20:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:50 INFO - 'PWD': '/builds/slave/test', 20:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:50 INFO - 'SHELL': '/bin/bash', 20:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:08:50 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:50 INFO - 'USER': 'cltbld', 20:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:50 INFO - 'XPC_FLAGS': '0x0', 20:08:50 INFO - 'XPC_SERVICE_NAME': '0', 20:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:50 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 20:08:50 INFO - Cleaning up... 20:08:50 INFO - Return code: 0 20:08:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:08:50 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')]} 20:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:50 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')]} 20:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:50 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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:08:50 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 20:08:50 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 20:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:50 INFO - 'HOME': '/Users/cltbld', 20:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:50 INFO - 'LOGNAME': 'cltbld', 20:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:50 INFO - 'MOZ_NO_REMOTE': '1', 20:08:50 INFO - 'NO_EM_RESTART': '1', 20:08:50 INFO - 'PAGER': '/bin/cat', 20:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:50 INFO - 'PWD': '/builds/slave/test', 20:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:50 INFO - 'SHELL': '/bin/bash', 20:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:08:50 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:50 INFO - 'USER': 'cltbld', 20:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:50 INFO - 'XPC_FLAGS': '0x0', 20:08:50 INFO - 'XPC_SERVICE_NAME': '0', 20:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:50 INFO - Downloading/unpacking psutil>=0.7.1 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:53 INFO - Installing collected packages: psutil 20:08:53 INFO - Running setup.py install for psutil 20:08:53 INFO - building 'psutil._psutil_osx' extension 20:08:53 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 20:08:54 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 20:08:54 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 20:08:54 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 20:08:54 INFO - building 'psutil._psutil_posix' extension 20:08:54 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 20:08:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:08:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:08:54 INFO - ^ 20:08:54 INFO - 1 warning generated. 20:08:54 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 20:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:54 INFO - Successfully installed psutil 20:08:54 INFO - Cleaning up... 20:08:54 INFO - Return code: 0 20:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:54 INFO - 'HOME': '/Users/cltbld', 20:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:54 INFO - 'LOGNAME': 'cltbld', 20:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:54 INFO - 'MOZ_NO_REMOTE': '1', 20:08:54 INFO - 'NO_EM_RESTART': '1', 20:08:54 INFO - 'PAGER': '/bin/cat', 20:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:54 INFO - 'PWD': '/builds/slave/test', 20:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:54 INFO - 'SHELL': '/bin/bash', 20:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:08:54 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:54 INFO - 'USER': 'cltbld', 20:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:54 INFO - 'XPC_FLAGS': '0x0', 20:08:54 INFO - 'XPC_SERVICE_NAME': '0', 20:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:08:57 INFO - Installing collected packages: mozsystemmonitor 20:08:57 INFO - Running setup.py install for mozsystemmonitor 20:08:57 INFO - Successfully installed mozsystemmonitor 20:08:57 INFO - Cleaning up... 20:08:57 INFO - Return code: 0 20:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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', '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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:08: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 blobuploader==1.2.4 20:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:57 INFO - 'HOME': '/Users/cltbld', 20:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:57 INFO - 'LOGNAME': 'cltbld', 20:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:57 INFO - 'MOZ_NO_REMOTE': '1', 20:08:57 INFO - 'NO_EM_RESTART': '1', 20:08:57 INFO - 'PAGER': '/bin/cat', 20:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:57 INFO - 'PWD': '/builds/slave/test', 20:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:57 INFO - 'SHELL': '/bin/bash', 20:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:08:57 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:57 INFO - 'USER': 'cltbld', 20:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:57 INFO - 'XPC_FLAGS': '0x0', 20:08:57 INFO - 'XPC_SERVICE_NAME': '0', 20:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:00 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09: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 20:09:01 INFO - Downloading docopt-0.6.1.tar.gz 20:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:01 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:01 INFO - Running setup.py install for blobuploader 20:09:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:01 INFO - Running setup.py install for requests 20:09:02 INFO - Running setup.py install for docopt 20:09:02 INFO - Successfully installed blobuploader requests docopt 20:09:02 INFO - Cleaning up... 20:09:02 INFO - Return code: 0 20:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:02 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')]} 20:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 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')]} 20:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:02 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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:09:02 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 20:09:02 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 20:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:02 INFO - 'HOME': '/Users/cltbld', 20:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:02 INFO - 'LOGNAME': 'cltbld', 20:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:02 INFO - 'MOZ_NO_REMOTE': '1', 20:09:02 INFO - 'NO_EM_RESTART': '1', 20:09:02 INFO - 'PAGER': '/bin/cat', 20:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:02 INFO - 'PWD': '/builds/slave/test', 20:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:02 INFO - 'SHELL': '/bin/bash', 20:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:09:02 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:02 INFO - 'USER': 'cltbld', 20:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:02 INFO - 'XPC_FLAGS': '0x0', 20:09:02 INFO - 'XPC_SERVICE_NAME': '0', 20:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:02 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ztzYbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-z53PQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-VKV2h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-AZTlUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-mQ2Bbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-DE5xmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-a7is7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-AtOzpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Y319T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:03 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-1nykTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KoKFjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-et47Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-t8_yNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-pGFjkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Oalcss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ZNjewM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:04 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-IoBSlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:04 INFO - Running setup.py install for manifestparser 20:09:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:04 INFO - Running setup.py install for mozcrash 20:09:05 INFO - Running setup.py install for mozdebug 20:09:05 INFO - Running setup.py install for mozdevice 20:09:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Running setup.py install for mozfile 20:09:05 INFO - Running setup.py install for mozhttpd 20:09:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Running setup.py install for mozinfo 20:09:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Running setup.py install for mozInstall 20:09:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:05 INFO - Running setup.py install for mozleak 20:09:06 INFO - Running setup.py install for mozlog 20:09:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:06 INFO - Running setup.py install for moznetwork 20:09:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:06 INFO - Running setup.py install for mozprocess 20:09:06 INFO - Running setup.py install for mozprofile 20:09:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:06 INFO - Running setup.py install for mozrunner 20:09:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:06 INFO - Running setup.py install for mozscreenshot 20:09:07 INFO - Running setup.py install for moztest 20:09:07 INFO - Running setup.py install for mozversion 20:09:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:07 INFO - Cleaning up... 20:09:07 INFO - Return code: 0 20:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:07 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')]} 20:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 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')]} 20:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:07 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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:09:07 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 20:09:07 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 20:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:07 INFO - 'HOME': '/Users/cltbld', 20:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:07 INFO - 'LOGNAME': 'cltbld', 20:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:07 INFO - 'MOZ_NO_REMOTE': '1', 20:09:07 INFO - 'NO_EM_RESTART': '1', 20:09:07 INFO - 'PAGER': '/bin/cat', 20:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:07 INFO - 'PWD': '/builds/slave/test', 20:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:07 INFO - 'SHELL': '/bin/bash', 20:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:09:07 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:07 INFO - 'USER': 'cltbld', 20:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:07 INFO - 'XPC_FLAGS': '0x0', 20:09:07 INFO - 'XPC_SERVICE_NAME': '0', 20:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-y3iDB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:07 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)) 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-YSGT7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:07 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)) 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-M1Wo4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:07 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)) 20:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:07 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-7kFAPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-LjQidv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-R99sHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ml_c6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-y82KMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-21CdH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-JR9Q2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-tgcBvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-tmB_nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:08 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)) 20:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:08 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-3rqXN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nNvqNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-NrMtcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-OPd8vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:09 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)) 20:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:09 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-zH8IZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:09 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)) 20:09:09 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)) 20:09:09 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)) 20:09:09 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)) 20:09:09 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)) 20:09:09 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)) 20:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:09 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 20:09:09 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 20:09:09 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 20:09:09 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 20:09:09 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 20:09:09 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 20:09:11 INFO - Downloading blessings-1.6.tar.gz 20:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:12 INFO - Installing collected packages: blessings 20:09:12 INFO - Running setup.py install for blessings 20:09:12 INFO - Successfully installed blessings 20:09:12 INFO - Cleaning up... 20:09:12 INFO - Return code: 0 20:09:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:12 INFO - Reading from file tmpfile_stdout 20:09:12 INFO - Current package versions: 20:09:12 INFO - blessings == 1.6 20:09:12 INFO - blobuploader == 1.2.4 20:09:12 INFO - docopt == 0.6.1 20:09:12 INFO - manifestparser == 1.1 20:09:12 INFO - mozInstall == 1.12 20:09:12 INFO - mozcrash == 0.17 20:09:12 INFO - mozdebug == 0.1 20:09:12 INFO - mozdevice == 0.48 20:09:12 INFO - mozfile == 1.2 20:09:12 INFO - mozhttpd == 0.7 20:09:12 INFO - mozinfo == 0.9 20:09:12 INFO - mozleak == 0.1 20:09:12 INFO - mozlog == 3.1 20:09:12 INFO - moznetwork == 0.27 20:09:12 INFO - mozprocess == 0.22 20:09:12 INFO - mozprofile == 0.28 20:09:12 INFO - mozrunner == 6.11 20:09:12 INFO - mozscreenshot == 0.1 20:09:12 INFO - mozsystemmonitor == 0.0 20:09:12 INFO - moztest == 0.7 20:09:12 INFO - mozversion == 1.4 20:09:12 INFO - psutil == 3.1.1 20:09:12 INFO - requests == 1.2.3 20:09:12 INFO - wsgiref == 0.1.2 20:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:12 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')]} 20:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:12 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')]} 20:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:12 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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:09:12 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 20:09:12 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 20:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:12 INFO - 'HOME': '/Users/cltbld', 20:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:12 INFO - 'LOGNAME': 'cltbld', 20:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:12 INFO - 'MOZ_NO_REMOTE': '1', 20:09:12 INFO - 'NO_EM_RESTART': '1', 20:09:12 INFO - 'PAGER': '/bin/cat', 20:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:12 INFO - 'PWD': '/builds/slave/test', 20:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:12 INFO - 'SHELL': '/bin/bash', 20:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:09:12 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:12 INFO - 'USER': 'cltbld', 20:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:12 INFO - 'XPC_FLAGS': '0x0', 20:09:12 INFO - 'XPC_SERVICE_NAME': '0', 20:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 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)) 20:09:12 INFO - Cleaning up... 20:09:12 INFO - Return code: 0 20:09:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:12 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')]} 20:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:12 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')]} 20:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:12 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 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:09:12 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 20:09:12 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 20:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:12 INFO - 'HOME': '/Users/cltbld', 20:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:12 INFO - 'LOGNAME': 'cltbld', 20:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:12 INFO - 'MOZ_NO_REMOTE': '1', 20:09:12 INFO - 'NO_EM_RESTART': '1', 20:09:12 INFO - 'PAGER': '/bin/cat', 20:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:12 INFO - 'PWD': '/builds/slave/test', 20:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:12 INFO - 'SHELL': '/bin/bash', 20:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:09:12 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:12 INFO - 'USER': 'cltbld', 20:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:12 INFO - 'XPC_FLAGS': '0x0', 20:09:12 INFO - 'XPC_SERVICE_NAME': '0', 20:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:13 INFO - Downloading/unpacking jsonschema 20:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:15 INFO - Downloading/unpacking functools32 (from jsonschema) 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 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 20:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:15 INFO - warning: no files found matching '*.txt' 20:09:15 INFO - no previously-included directories found matching 'build' 20:09:15 INFO - no previously-included directories found matching 'dist' 20:09:15 INFO - no previously-included directories found matching '.git*' 20:09:15 INFO - Installing collected packages: jsonschema, functools32 20:09:16 INFO - Running setup.py install for functools32 20:09:16 INFO - warning: no files found matching '*.txt' 20:09:16 INFO - no previously-included directories found matching 'build' 20:09:16 INFO - no previously-included directories found matching 'dist' 20:09:16 INFO - no previously-included directories found matching '.git*' 20:09:16 INFO - Successfully installed jsonschema functools32 20:09:16 INFO - Cleaning up... 20:09:16 INFO - Return code: 0 20:09:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccd7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cce7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fead0df4320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, '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.OLlehdlwOY/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.t4OVTqiMMC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 20:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:16 INFO - 'HOME': '/Users/cltbld', 20:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:16 INFO - 'LOGNAME': 'cltbld', 20:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:16 INFO - 'MOZ_NO_REMOTE': '1', 20:09:16 INFO - 'NO_EM_RESTART': '1', 20:09:16 INFO - 'PAGER': '/bin/cat', 20:09:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:16 INFO - 'PWD': '/builds/slave/test', 20:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:16 INFO - 'SHELL': '/bin/bash', 20:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:09:16 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:16 INFO - 'USER': 'cltbld', 20:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:16 INFO - 'XPC_FLAGS': '0x0', 20:09:16 INFO - 'XPC_SERVICE_NAME': '0', 20:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:16 INFO - Downloading/unpacking flake8 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:09:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:09:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:09:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:20 INFO - no previously-included directories found matching 'docs/_build' 20:09:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:09:20 INFO - Running setup.py install for pep8 20:09:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:09:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:09:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:09:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:09:20 INFO - no previously-included directories found matching 'docs/_build' 20:09:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:09:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:09:20 INFO - Cleaning up... 20:09:20 INFO - Return code: 0 20:09:20 INFO - Running post-action listener: _resource_record_post_action 20:09:20 INFO - Running post-action listener: _start_resource_monitoring 20:09:20 INFO - Starting resource monitoring. 20:09:20 INFO - ##### 20:09:20 INFO - ##### Running install step. 20:09:20 INFO - ##### 20:09:20 INFO - Running pre-action listener: _resource_record_pre_action 20:09:20 INFO - Running main action method: install 20:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:20 INFO - Reading from file tmpfile_stdout 20:09:20 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:21 INFO - Reading from file tmpfile_stdout 20:09:21 INFO - Output received: 20:09:21 INFO - Usage: mozinstall [options] installer 20:09:21 INFO - Options: 20:09:21 INFO - -h, --help show this help message and exit 20:09:21 INFO - -d DEST, --destination=DEST 20:09:21 INFO - Directory to install application into. [default: 20:09:21 INFO - "/builds/slave/test"] 20:09:21 INFO - --app=APP Application being installed. [default: firefox] 20:09:21 INFO - mkdir: /builds/slave/test/build/application 20:09:21 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'] 20:09:21 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 20:09:54 INFO - Reading from file tmpfile_stdout 20:09:54 INFO - Output received: 20:09:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:09:54 INFO - Running post-action listener: _resource_record_post_action 20:09:54 INFO - ##### 20:09:54 INFO - ##### Running run-tests step. 20:09:54 INFO - ##### 20:09:54 INFO - Running pre-action listener: _resource_record_pre_action 20:09:54 INFO - Running main action method: run_tests 20:09:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:54 INFO - 2016-04-25 20:09:54.629 screenresolution[2225:19000] starting screenresolution argv=screenresolution get 20:09:54 INFO - 2016-04-25 20:09:54.632 screenresolution[2225:19000] Display 0: 1600x1200x32@60 20:09:54 INFO - 2016-04-25 20:09:54.638 screenresolution[2226:19002] starting screenresolution argv=screenresolution list 20:09:54 INFO - Available Modes on Display 0 20:09:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:54 INFO - Intel Iris: 20:09:54 INFO - Chipset Model: Intel Iris 20:09:54 INFO - Type: GPU 20:09:54 INFO - Bus: Built-In 20:09:54 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:54 INFO - Vendor: Intel (0x8086) 20:09:54 INFO - Device ID: 0x0a2e 20:09:54 INFO - Revision ID: 0x0009 20:09:54 INFO - Displays: 20:09:54 INFO - Display: 20:09:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:54 INFO - Display Serial Number: 1600x1200 60 20:09:54 INFO - Main Display: Yes 20:09:54 INFO - Mirror: Off 20:09:54 INFO - Online: Yes 20:09:54 INFO - Rotation: Supported 20:09:54 INFO - Return code: 0 20:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:54 INFO - Python 2.7.3 20:09:54 INFO - Return code: 0 20:09:54 INFO - grabbing minidump binary from tooltool 20:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:54 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 0x10cb76e00>, '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 0x10c9dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb71b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:54 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 20:09:54 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 20:09:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:54 INFO - Return code: 0 20:09:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:09:56 INFO - Return code: 0 20:09:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OLlehdlwOY/Render', 20:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:56 INFO - 'HOME': '/Users/cltbld', 20:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:56 INFO - 'LOGNAME': 'cltbld', 20:09:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:56 INFO - 'MOZ_NO_REMOTE': '1', 20:09:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:56 INFO - 'NO_EM_RESTART': '1', 20:09:56 INFO - 'PAGER': '/bin/cat', 20:09:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:56 INFO - 'PWD': '/builds/slave/test', 20:09:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:56 INFO - 'SHELL': '/bin/bash', 20:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t4OVTqiMMC/Listeners', 20:09:56 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 20:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:56 INFO - 'USER': 'cltbld', 20:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:56 INFO - 'XPC_FLAGS': '0x0', 20:09:56 INFO - 'XPC_SERVICE_NAME': '0', 20:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:09:56 INFO - mozversion application_buildid: 20160425181356 20:09:56 INFO - mozversion application_changeset: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 20:09:56 INFO - mozversion application_display_name: Nightly 20:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:56 INFO - mozversion application_name: Firefox 20:09:56 INFO - mozversion application_remotingname: firefox 20:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:09:56 INFO - mozversion application_vendor: Mozilla 20:09:56 INFO - mozversion application_version: 49.0a1 20:09:56 INFO - mozversion platform_buildid: 20160425181356 20:09:56 INFO - mozversion platform_changeset: f4fd92a0496fd6d1ef7fe87ebaeb002cc3d79ec3 20:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:09:56 INFO - mozversion platform_version: 49.0a1 20:09:56 INFO - using testdate: 1461640196 20:09:56 INFO - actual date: 1461640196 20:09:56 INFO - starting webserver on 'localhost:51399' 20:09:56 INFO - SUITE-START | Running 2 tests 20:09:56 INFO - TEST-START | dromaeo_css 20:09:56 INFO - operating with platform_type : mac_ 20:09:56 INFO - Initialising browser for dromaeo_css test... 20:09:56 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp1znNJ0/profile http://localhost:51399/getInfo.html) 20:09:59 INFO - PROCESS | 2244 | __metrics Screen width/height:1600/1200 20:09:59 INFO - PROCESS | 2244 | colorDepth:24 20:09:59 INFO - PROCESS | 2244 | Browser inner width/height: 1024/689 20:09:59 INFO - PROCESS | 2244 | __metrics 20:09:59 ERROR - PROCESS | 2244 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:09:59 INFO - TEST-INFO | 2244: exit 0 20:09:59 INFO - Browser initialized. 20:09:59 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:59 INFO - TEST-INFO | started process 2247 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp1znNJ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:11 INFO - PROCESS | 2247 | RSS: Main: 249815040 20:10:11 INFO - PROCESS | 2247 | 20:11:01 INFO - PROCESS | 2247 | 1461640261437 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] 20:13:12 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:51399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51399/tests/dromaeo/cssquery-ext.html) 20:13:13 INFO - PROCESS | 2247 | RSS: Main: 261857280 20:13:13 INFO - PROCESS | 2247 | 20:16:15 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:51399/tests/dromaeo/cssquery-ext.html (next: http://localhost:51399/tests/dromaeo/cssquery-jquery.html) 20:16:16 INFO - PROCESS | 2247 | RSS: Main: 273723392 20:16:16 INFO - PROCESS | 2247 | 20:19:18 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:51399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51399/tests/dromaeo/cssquery-mootools.html) 20:19:18 INFO - PROCESS | 2247 | RSS: Main: 275644416 20:19:18 INFO - PROCESS | 2247 | 20:22:20 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:51399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51399/tests/dromaeo/cssquery-prototype.html) 20:22:21 INFO - PROCESS | 2247 | RSS: Main: 277901312 20:22:21 INFO - PROCESS | 2247 | 20:25:23 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:51399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51399/tests/dromaeo/cssquery-yui.html) 20:25:24 INFO - PROCESS | 2247 | RSS: Main: 280158208 20:25:24 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | Cycle 1(1): loaded http://localhost:51399/tests/dromaeo/cssquery-yui.html (next: http://localhost:51399/tests/dromaeo/cssquery-dojo.html) 20:28:27 INFO - PROCESS | 2247 | RSS: Main: 281268224 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | __start_tp_report 20:28:27 INFO - PROCESS | 2247 | _x_x_mozilla_page_load 20:28:27 INFO - PROCESS | 2247 | _x_x_mozilla_page_load_details 20:28:27 INFO - PROCESS | 2247 | |i|pagename|runs| 20:28:27 INFO - PROCESS | 2247 | |0;dojo.html;3448.1552019755154;3458.481227815828;3494.6680065393793;3506.929861402772;3530.6116327204018;5553.6948817028015;5686.431356864311;5732.627379220347;5749.482546570808;5763.654180749158;5645.8588535286635;5744.827655170341;5749.56878234132;5796.884062318762;5848.795292164775;5148.794048238075;5153.510416510426;5188.558972487343;5189.169732842746;5230.947690523084;315.0804979852916;5199.09015922214;5212.687238765668;5241.39723931747;5278.47215278473;4262.381954616563;5164.096283150452;5169.914317993226;5199.116150254447;5215.608829337815;4213.662906967435;5027.899442011176;5108.616853735947;5215;5314.012059254105;3847.8648798604477;4624.722516648978;5132.794688212467;5145.742712864379;5197.506236907488;4483.663725220622;4563.657725670555;4588.4723256825555;5713.257276554063;5716.485516303511;6127;6174.413430724074;6208.87582248357;6249.625022498664;6276.686165691697;6226.2839773426185;6227.3772622737815;6243.500519958392;6261.7182226799905;6283.403076707706;5836.708164591753;5857.150713146612;5867.765289388462;5870.589058765888;5900.734466948998;6210.099535567408;6261.279952805395;6265.937340626535;6345.365463453618;6349.142865713162;6179.16581261533;6183.319834818167;6194.318624951252;6198.845028874314;6207.099970504251;6190.350013248544;6220.315765265817;6246.250449945945;6257.655828929362;6269.965455699849;6109.358517355614;6144.095330447575;6192.885280649526;6219.533534984804;6272.027835685476;6104.732011601605;6135.754569817246;6230;6270.592411493239;6275.717592708339;4049.190161967618;4969.950300497021;4972.403311602631;5031.647784655039;5033.345665063518;3350.329934013207;3938.0548668319398;4311.568843115726;4378.80295386702;4466.709663871838;5608.6073974821375;5724.8282551523525;5812.970935145382;5823.417658234142;5885.058390657474;6252.280987686474;6259.998400256029;6275.843103922347;6281.120643109968;6345.33373995733;4578.679492435497;5689.402612725687;5824.213731146241;5846.853828654318;5917.112473089303;5405.78376864921;5440;5442.129259318569;5442.6462279951675;5475.370332411823;6204.286507051746;6396;6399.776007839796;6408.679566021773;6431.646259455775;6151.84620384494;6213.130161777445;6240.687965601793;6244.406781355764;6247.375262473716;6362.968185159045;6399.456046235936;6401.071844582416;6407.0709747085475;6416.518761092843;6046.395360463918;6132.20254427538;6235.3452887446165;6238.781642642486;6240.500759939285;6151.477124444473;6176.598521096114;6228.0969259456215;6253.624782513064;6257.4681152102585;5228;6103.870783904992;6148.4466398022605;6171.907421388593;6193.907091393543;6043.456088952015;6113.57204995646;6124.472479235402;6138.07928810682;6147.354527774698;5769.769209231584;5857.970710146422;5926.140709596998;5985.730642121028;5989.610675306091;6148.47737942262;6157.415045570664;6183.288921774054;6183.412575805291;6204.875902482016;5824.767009319579;5962.4633782959745;6022;6029.849253768691;6087.878242435215 20:28:27 INFO - PROCESS | 2247 | |1;ext.html;479.2427963817169;501.4484067525721;537.7311344327836;599.9940000599994;625.6527627166923;38772.80613596932;39281.214375712465;39412.40881386781;39493.012674683145;39543.209135817306;40176.39735403971;40294.19411611766;40911.38632920509;40944.771656850266;41004.79497602508;9363.344565880374;9542.188913942324;9607.991160928106;9646.324757266993;9658.03419658032;9471.147596716328;9552.283578731589;9663.371880827759;9700.078492543196;9726.221902247838;9686.273529485281;9696.51517424126;9775.169110625606;9788.119069283763;9791.853122203138;8238.423310368276;9658.75853103671;9732.270079744048;9753.707388778348;9754.609815607368;8304.335653147795;9569.90430095697;9640.517974101267;9725.221982241474;9728;39211.8039409804;39447.01382465433;39640.405393919114;39808;39989.60010399917;2750.546159883637;2793.5669971154302;3092.2887735820664;3189.9043028708943;3268.7221586165206;22887.198948036737;26383.208503744918;27585.380227946964;27794;28113.437731245464;2673.3183038325296;2677.919662410131;2722.8366298022183;2865.8423786691724;2912.9708702912912;377872;380415;381501;381595;381765;62414.68792656008;62635.68682156651;62664;62735.372646272954;62882;61828.69085654543;62363.37636623666;62997;63210.73578528496;63227.36772632215;14010.719785604231;16900.492985210218;17184.656306874043;17192.484225473258;17304.826951730323;13048.673783155307;13055.412506437233;13104.148230364995;13133.212007279593;13138.671533211555;17292.654146917244;19275.51811204703;19800;19874.801251987585;20231.291904783262;7049.964750176319;8269.46248493846;8399.538025408661;8405.511712639309;8438.66245350179;903.6566104880103;926.3746970794687;1010.8180527505119;1013.2704452793977;1058.4599407861697;26477.47045059088;30087;30212.54681179784;30375.848120759696;30659.8467007668;1048.2714513413257;1049.803224324271;1109.4674556213063;1146.5471138900089;1195.8146487294484;15343;15508.612284692746;15694.9215253923;15746.606334841492;15872.353945748386;661213;662785;664701;673058;676140;53915.19127213095;58168;60778;61138;61218;1417.121384741467;1443.0620096937075;1454.2219912346843;1465.4905447389206;1470.4926800253681;27955.881764729183;28043.298917527223;28426.147215583565;28700;28910.421791564473;52371;52550.47449525456;52615;52840;54512.72743636256;627071;627185;632923.8353808201;635143;637252;38170.23659526849;42642.933926652084;43211.56788432076;43262.78368608137;43270.567294326655;42574;42761;43033.99897948637;43343.78328108339;43682.563174367846;35608.46587301244;35991.460128098624;36235;36382.8180859094;36988.81505592455;35572.110697232776;36052.694230616034;36236.81881590575;37240.88277351684;38328;36689;37240.627593723715;37359.87920362393;37377;37464.812675936446;29840.70159298466;32623;33100.83449582737;33651.3269734599;33705.49441758425;24582.631260531463;24623.876880615484;24682.765861706484;25110.874445628386;25112.62331065072 20:28:27 INFO - PROCESS | 2247 | |2;jquery.html;364.80482941626235;371.67478456350693;393.16060211448564;405.89852536865783;410.5996653263067;15071.095734255925;18061.458156255318;18368.540786480346;19833.603327933433;22251;19457.708134377997;20023.39812814975;20080;21444.57110857782;21980.89009554954;5155.613329000321;5769.1346298055205;5887.793927212538;5973.4623883850445;6068.453839154476;5159.4324624291485;5831.329397119322;5916.88166236675;5954.910676339859;5979.1330257112695;5573.944260557403;5914.053751399777;5932.762689492437;5942.702864856761;5943.286805583336;5825.796097136601;5846.444587764156;5851.824445266649;5920.585559010871;6006.609570377956;5754.395788442237;5797.768089276424;5837.657338812054;5840.795572154997;5871.295444546639;13369.264690442022;15063.472778452811;21794.673079903812;24397.634035489304;25170.87414562934;2035.9796402035938;2107.1571371451387;2404.471016376412;2539.593665013589;2718.9320266993286;9978.501074946296;10156.441395723232;10190.694279171637;10263.79472410555;10288.176945844314;1739.6346767178907;1778.9644207115914;1820.29008686611;1838.8231531819647;1842.1802297977406;105281.94718052875;110236;110533.44733276362;110994;111452;11314.943425282985;11532.88467115335;11652.592159274385;11817.468213930393;11833.644990650295;13484.595462136152;13811.378487968066;14295.642608934651;15173.62065948338;15263.923680381527;6977.023216749659;8356.707515236938;8799.604017819214;8842.292616590657;8849.51327676971;8613.138686131337;8635.611397487128;8638.913610863936;8641.265492433213;8713.346499012472;4616.884577885579;4675.625949923998;4703.106409782131;4751.239801631722;4782.95217047832;1931.9830653336226;1957.0703915639956;2018.9192432302837;2025.665765148734;2033.2680235115347;703.8733028055;958.2334132693817;963.8000689142063;986.6250824686573;1043.4521876015153;15208.695826083416;20369.08339124743;20717.482062948246;21314.254001109886;21391.930403479764;866.7139843851514;869.9826003479895;931.8182954323977;943.1843700875787;1019.6686077024997;10879.456027198608;11093.83359249612;11153.103972324725;11154.386508742096;11220.943895280634;642496;649131;666095.646677643;668462;671127;89029;99917;113372.43313783543;118656;123854;985.7190700650281;1001.1540248490014;1002.8545860850281;1019.7705516258783;1056.0442799266675;17842;18085.276588936296;18153;18181.363652272106;18475.353362632242;29611.96358127455;41195.70434365304;43792.34311485394;46265.76867115643;47183.528164717914;50574;55955;60291.625635462675;65290;72126.27873721195;7652.464327497022;7861.960690196513;7896.526208427513;8027.518348899085;8253.257206851413;10871.945640271748;12347.259164450163;12462.563810266598;12713.80929286043;12788.808167877676;7947.245011723877;10705.839412408975;10880.347179169275;10884.455777211266;11123.888761112285;8595.87106193395;10719.839202411815;10925.065321020506;11045.171612129283;11251.212415130862;11041.779164416826;11048.834267486154;11099.445027748741;11199.944000279946;11221.66335009951;8056.637451314587;8201.79495512617;8243.629036693243;8330.750077497685;8511.702090426805;9757.26820488452;10545.630902918361;10644.787104258026;11129.55481780752;11166.553337866395 20:28:27 INFO - PROCESS | 2247 | |3;mootools.html;1621.4324986254812;1643.038822288961;1879.0510792050013;1884.5288677830542;1913.9043047847604;7728.613569321526;8191.836163276731;8210.794730131742;8549.102344253857;8605.526696031715;8202.220789025034;8231.259186673198;8324.667013319475;8337.333013358932;8343.874841877361;2388.4984153327823;2408.7350391456926;2430.744771798962;2432.8783560821976;2434.513097380522;2386.8209884258663;2415.118481754165;2425.320910145162;2429.7813196812285;2435.330284171849;2408.5664580375524;2420.201333559921;2424.5635785558593;2436.8181432005463;2439.6828412306377;2391.0794344177443;2391.7608239176116;2401.435662619283;2403.483251101013;2416.6254230594286;2034.2473284884688;2386.0455817672896;2404.1825779235146;2410.3612542676206;2419.8911049002663;8332;8403.327733781283;8460.450070745383;8478.66085356585;8480.067192608809;4704.741239231841;4860.392450943632;4992.925106123411;5196.610254230948;5225.764840582183;3398.3543126806076;3463.913402164966;3537.4163263061564;3572.1248294167835;3595.1551385424405;1040.881805525759;1048.958041678332;1050.5010120192924;1050.7110544600296;1051.894810518942;10969.506372213269;10980.341179529254;11031.889681103166;11048.116150707923;11072.889271107266;4633.397658304466;4675.4155730533685;4784.378030856036;4786.521347865255;4793.808247670054;9472.668456603986;9552.471604543378;9574.47340396271;9598.040195980346;9614.471204083702;5206.167013277933;5236;5292.259083728281;5312.1766126250495;5354.170103633943;3920.4707364506;4316.179925814085;4679.532046795293;4819.759012049383;4841.273808928689;3796.126890815128;3825.713071519647;3898.6491215790147;3923.9215215695526;3938.7636741795586;1068.9893101069044;1107.9612213572648;1123.337231033694;1124.848145500347;1171.6250799744;861.8448679237797;885.2342723544087;902.1519771414848;941.75985123793;954.3224310739453;5680.233168522197;5920.792772253037;5944.464998150101;5967.104934259895;6014.218151640259;448.88104652267174;459.07954551124783;464.2641413359795;464.47746285428894;467.8035225205422;3876.1666241758157;3973.900652483711;3980.283548961215;4053.3919912012843;4076.1032572834524;9513.143817056498;9696.75758106053;9892.109710125978;9981.251406144424;10018.549165287579;9832.852507212398;9841.163501102486;9855.31012829095;9906.405615663083;9906.653267135616;7613.352865006536;7640.197779233212;7730.342920851791;7996.200379961957;8103.351731861437;5865.208196893364;5888.234529511307;5942.465178133989;5975.701214939322;5995.190649262294;8147.959260203661;9675.903240967782;9697.806043879224;9723.611055557698;9797.412155270707;9540.809183816145;9786.853197201905;9819.607215711578;9845.261605379768;9946.602135914482;7363.889541656772;7528.247175282428;7619;7635.618219089134;7654.081510218809;7981.760547183594;7994.2405471480115;8107.716229931924;8112.432129751097;8210.01479822425;7149.249328820607;7444.99492568518;7460.403167746459;7571.507851989603;7600.087989441303;7312.670929808065;7327.523710958771;7360;7480.775576732707;7581.6209189541405;6344.809655710336;6436.13112229843;6477.093206951125;6494.285628580947;6512.446442052289;4886.877828054327;5115.360579927509;5153.433122356612;5187.533122019036;5206.0368831766245;5153.974230128825;5158.446568948395;5182.844514664566;5229.607779416635;5298.682079075268 20:28:27 INFO - PROCESS | 2247 | |4;prototype.html;314.81740590457537;315.1302405361203;317.2591997685403;324.2234847540143;324.39338437122586;4718.343283954937;5305.920411193835;5413;5435.755391007404;5505.587080968929;4605.894585299529;4665.393498845146;5247.795925711201;5340.786368545254;5371.328583927009;3470.77439966402;3762.604926482721;4129.442525259082;4143.606357396043;4146.958530414688;3234.8973167441236;4118.238125946695;4120.484939382577;4122.814473348706;4149.460570125894;3711.294853977749;3881.592432794558;4072.6538244249273;4103.5280942691525;4131.566185550519;3875.379939209741;4104.220198162339;4106.240345536085;4143.647789937859;4182.393552934838;3003.9035751950382;3082.828525160447;3573.767050367619;3601.4237721964623;3602.0094474019593;4322.978385108086;4491.011977364975;5147.944671342366;5182.585393168538;5232.73836308183;4467.865964021084;4748.264019077014;4761.26200438929;4770.260609605517;4783.378160839104;4974.552290293891;5419.430959749209;5691.589018510646;5701.6864072476;5706.058500347438;3381.661833816623;3970.5830887756947;4020.839166433339;4024;4030.052937559671;4908.950910490921;5773;5928.822135335947;5974.940250597482;6004.5796794224425;3420;3896.279188350164;4058.8838069531116;4091.018155642624;4113.547509773923;3869.400242962289;4160.521540022936;4173.791310434466;4174.666026717916;4183;4761.976190119097;4776.761161941889;4780.665353425296;4800.73595952226;4802.73584952824;4149.211649786531;5414.891702166014;5579;5787.652740835563;5804.390538993429;1494.0886059503694;1515.1515151515187;1521.4979056911193;1526.8167819861687;1527.823575846592;939.957701903416;992.3450522655013;997.486294558303;1015.9593616255415;1036.1969473657975;5616.213730077792;5645.858853528613;5680.77276908919;5717.485426311652;5724.713764311768;5709.029464990961;5907.4683278505145;6284.37156284377;6292.766068045869;6297;4767.903382222039;5206.583473322125;5435.83692489226;5698.176583493242;5717.627769335413;3285.5071739239306;3305.669433056675;3308.2556424804707;3331.0506505645776;3382.1375549234785;5671.8865622688145;6363.7772677956045;6508.479321654257;6519.696060787766;6566.67166641666;5149.6910185389;6346.68346053687;6385.744570217233;6409.551331406757;6451.774187903401;5395.030813752874;6456.322086180883;6522.771702990467;6538.378854008862;6567.3760992706575;5888.175655408332;6283.434490895658;6292.590981586182;6301.38492525615;6316.936830631635;5113.284140220447;5856.092305692625;5936.673482958478;6143.447089761943;6190.969045154746;5407.864803379947;6199.287081985449;6533.967330163509;6549.803505894831;6590.143281373391;3782.432635104756;4304.634106101016;4318.762468064287;4322.632576231055;4396.296592545177;5199.376074871039;6234.2830574482705;6253.687315634109;6313.305536390902;6321.4196450887275;5638.661680299195;6037.1927053920135;6056.636601803906;6071.630245213949;6076.118962750465;4990.925136123034;5367.624266301322;5501.834944951658;5960.225170727777;6013.7293821779;4297.806598703003;4702.835400760957;5914.142449344907;5919.230500034968;5921.467067963904;4975.303457515878;5654.802081927113;5663.2071509989455;5663.85840353978;5789.739461724317;5541.418151094077;5552.7223638818705;5570.387257401763;5571.777128914798;5638.6898720569125 20:28:27 INFO - PROCESS | 2247 | |5;yui.html;525.9368875734912;664.4219529009762;665.6172700697099;676.2358534855613;685.0101603183402;14922.477713280025;14968.476103336372;15000.324985375657;15074.321655525486;15134.016288941211;13775.10461819981;13782.517611883586;13839.861601383984;13851;13885.652858678539;717.8779607466718;878.6178012564523;895.4537731983469;913.1234015345276;915.1169121797465;901.3104974694364;905.8867641544807;911.3028533172129;916.505087252886;916.6837441082849;839.4459656626627;943.4292253186826;963.6771681486675;965.7971825916566;969.2343048991288;949.710338346804;954.9092836180552;956.9282303827206;958.0132463562542;958.0850287974968;715.9391451726609;722.9746958856415;725.1226016520017;725.7459889038847;726.1975517053633;14447.277636118257;14640.90193235501;14707;14723.116613003254;14779.926100369537;12320.445579948924;12539.24764514123;12586.622401327975;12625.684357891034;12780.04149688777;9722.708318750449;10039.89960100397;10041.497925103715;10294.124999375063;10424.322419042737;3402.0644322811177;3446.5691788526433;3447.5518182636347;3454.671806178409;3476.1135910342955;82381.58809205976;83362.58318708367;84808;84913;85779.99999999937;9411.764705882271;9446.291528135418;9467.147956683793;9564.091411315914;9677.806443871083;20375.79624203739;20538.17847286122;20962.685559716618;21147.78852211489;21213.575728485343;7556.886646700304;7589.924100759032;7674.232576742281;7761.7671469855995;7827.217278272127;3698.9075273118387;4147.0461793787;4185.100203456272;4205.810738516774;4238.23711731885;3441.6214216436174;3475.982620086934;3550.183457804668;3552.982235088808;3560.537130173061;647.870425914819;648.9026646003043;649.2695717318018;651.3616655677463;655.8031592343991;523.2151772341488;565.21435205065;569.7550053477045;589.6609449566516;589.8289496046184;7129.643517824088;7470.2903224193615;7980.122186559473;7991.160928102582;8310.875336869953;536.2813829468531;546.0716781471515;565.5164834066813;589.590234786819;597.8893904627657;3579.266250418658;3819.560750513671;3861.1505468796818;3985.1830374773103;4024.9798751006642;89870;90598.54700726454;91272.54363728139;94953.5252323734;97303.51348243213;64372.678136609014;74980.62509687417;75743.48513029708;78259;78812.60593696995;63277.68361158165;64304.35695643077;65085.67457162779;65733;68519.28701782395;7324.523905946096;7559.357454616419;7723.729669461542;7729.3430058445665;8247.134050924567;41613.79193104015;44484.77757611191;44502.65968083851;44580.33129502995;44633.33050004188;61657;62754.68622656858;63573.364266356744;65681.34318656752;66486.33513664996;11107.222494425312;11127.443627818415;11282.605108821152;11337.716557086138;11547.826782598437;11832.467538960595;11922.642320730392;12259.141860069709;12381.62855114348;12452;11451.770964580495;11558.653240402802;11708.414579270831;11773.117016223989;11881;11339.943300283447;11634.418279085843;11823.527058917547;11834.407906200717;12196.024318054357;10328.173746100445;11165.49755260999;11349.319040857576;11388.145889058189;11665.825012624988;7810.804729881798;9592.280578956746;9666.661666841908;9859.65491207833;9925.305228633926;9552.092551207625;9666.75833104178;9724.076212759777;9801.85297220528;9829 20:28:27 INFO - PROCESS | 2247 | __end_tp_report 20:28:27 INFO - PROCESS | 2247 | __start_cc_report 20:28:27 INFO - PROCESS | 2247 | _x_x_mozilla_cycle_collect,425 20:28:27 INFO - PROCESS | 2247 | __end_cc_report 20:28:27 INFO - PROCESS | 2247 | __startTimestamp1461641307289__endTimestamp 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | ------- Summary: start ------- 20:28:27 INFO - PROCESS | 2247 | Number of tests: 6 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | [#0] dojo.html Cycles:165 Average:5669.00 Median:5989.61 stddev:839.87 (14.0%) stddev-sans-first:824.18 20:28:27 INFO - PROCESS | 2247 | Values: 3448.2 3458.5 3494.7 3506.9 3530.6 5553.7 5686.4 5732.6 5749.5 5763.7 5645.9 5744.8 5749.6 5796.9 5848.8 5148.8 5153.5 5188.6 5189.2 5230.9 315.1 5199.1 5212.7 5241.4 5278.5 4262.4 5164.1 5169.9 5199.1 5215.6 4213.7 5027.9 5108.6 5215.0 5314.0 3847.9 4624.7 5132.8 5145.7 5197.5 4483.7 4563.7 4588.5 5713.3 5716.5 6127.0 6174.4 6208.9 6249.6 6276.7 6226.3 6227.4 6243.5 6261.7 6283.4 5836.7 5857.2 5867.8 5870.6 5900.7 6210.1 6261.3 6265.9 6345.4 6349.1 6179.2 6183.3 6194.3 6198.8 6207.1 6190.4 6220.3 6246.3 6257.7 6270.0 6109.4 6144.1 6192.9 6219.5 6272.0 6104.7 6135.8 6230.0 6270.6 6275.7 4049.2 4970.0 4972.4 5031.6 5033.3 3350.3 3938.1 4311.6 4378.8 4466.7 5608.6 5724.8 5813.0 5823.4 5885.1 6252.3 6260.0 6275.8 6281.1 6345.3 4578.7 5689.4 5824.2 5846.9 5917.1 5405.8 5440.0 5442.1 5442.6 5475.4 6204.3 6396.0 6399.8 6408.7 6431.6 6151.8 6213.1 6240.7 6244.4 6247.4 6363.0 6399.5 6401.1 6407.1 6416.5 6046.4 6132.2 6235.3 6238.8 6240.5 6151.5 6176.6 6228.1 6253.6 6257.5 5228.0 6103.9 6148.4 6171.9 6193.9 6043.5 6113.6 6124.5 6138.1 6147.4 5769.8 5858.0 5926.1 5985.7 5989.6 6148.5 6157.4 6183.3 6183.4 6204.9 5824.8 5962.5 6022.0 6029.8 6087.9 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | [#1] ext.html Cycles:180 Average:69574.66 Median:39246.51 stddev:153900.91 (392.1%) stddev-sans-first:154245.21 20:28:27 INFO - PROCESS | 2247 | Values: 479.2 501.4 537.7 600.0 625.7 38772.8 39281.2 39412.4 39493.0 39543.2 40176.4 40294.2 40911.4 40944.8 41004.8 9363.3 9542.2 9608.0 9646.3 9658.0 9471.1 9552.3 9663.4 9700.1 9726.2 9686.3 9696.5 9775.2 9788.1 9791.9 8238.4 9658.8 9732.3 9753.7 9754.6 8304.3 9569.9 9640.5 9725.2 9728.0 39211.8 39447.0 39640.4 39808.0 39989.6 2750.5 2793.6 3092.3 3189.9 3268.7 22887.2 26383.2 27585.4 27794.0 28113.4 2673.3 2677.9 2722.8 2865.8 2913.0 377872.0 380415.0 381501.0 381595.0 381765.0 62414.7 62635.7 62664.0 62735.4 62882.0 61828.7 62363.4 62997.0 63210.7 63227.4 14010.7 16900.5 17184.7 17192.5 17304.8 13048.7 13055.4 13104.1 13133.2 13138.7 17292.7 19275.5 19800.0 19874.8 20231.3 7050.0 8269.5 8399.5 8405.5 8438.7 903.7 926.4 1010.8 1013.3 1058.5 26477.5 30087.0 30212.5 30375.8 30659.8 1048.3 1049.8 1109.5 1146.5 1195.8 15343.0 15508.6 15694.9 15746.6 15872.4 661213.0 662785.0 664701.0 673058.0 676140.0 53915.2 58168.0 60778.0 61138.0 61218.0 1417.1 1443.1 1454.2 1465.5 1470.5 27955.9 28043.3 28426.1 28700.0 28910.4 52371.0 52550.5 52615.0 52840.0 54512.7 627071.0 627185.0 632923.8 635143.0 637252.0 38170.2 42642.9 43211.6 43262.8 43270.6 42574.0 42761.0 43034.0 43343.8 43682.6 35608.5 35991.5 36235.0 36382.8 36988.8 35572.1 36052.7 36236.8 37240.9 38328.0 36689.0 37240.6 37359.9 37377.0 37464.8 29840.7 32623.0 33100.8 33651.3 33705.5 24582.6 24623.9 24682.8 25110.9 25112.6 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | [#2] jquery.html Cycles:180 Average:34899.95 Median:13401.05 stddev:108875.57 (812.4%) stddev-sans-first:109150.11 20:28:27 INFO - PROCESS | 2247 | Values: 364.8 371.7 393.2 405.9 410.6 15071.1 18061.5 18368.5 19833.6 22251.0 19457.7 20023.4 20080.0 21444.6 21980.9 5155.6 5769.1 5887.8 5973.5 6068.5 5159.4 5831.3 5916.9 5954.9 5979.1 5573.9 5914.1 5932.8 5942.7 5943.3 5825.8 5846.4 5851.8 5920.6 6006.6 5754.4 5797.8 5837.7 5840.8 5871.3 13369.3 15063.5 21794.7 24397.6 25170.9 2036.0 2107.2 2404.5 2539.6 2718.9 9978.5 10156.4 10190.7 10263.8 10288.2 1739.6 1779.0 1820.3 1838.8 1842.2 105281.9 110236.0 110533.4 110994.0 111452.0 11314.9 11532.9 11652.6 11817.5 11833.6 13484.6 13811.4 14295.6 15173.6 15263.9 6977.0 8356.7 8799.6 8842.3 8849.5 8613.1 8635.6 8638.9 8641.3 8713.3 4616.9 4675.6 4703.1 4751.2 4783.0 1932.0 1957.1 2018.9 2025.7 2033.3 703.9 958.2 963.8 986.6 1043.5 15208.7 20369.1 20717.5 21314.3 21391.9 866.7 870.0 931.8 943.2 1019.7 10879.5 11093.8 11153.1 11154.4 11220.9 642496.0 649131.0 666095.6 668462.0 671127.0 89029.0 99917.0 113372.4 118656.0 123854.0 985.7 1001.2 1002.9 1019.8 1056.0 17842.0 18085.3 18153.0 18181.4 18475.4 29612.0 41195.7 43792.3 46265.8 47183.5 50574.0 55955.0 60291.6 65290.0 72126.3 7652.5 7862.0 7896.5 8027.5 8253.3 10871.9 12347.3 12462.6 12713.8 12788.8 7947.2 10705.8 10880.3 10884.5 11123.9 8595.9 10719.8 10925.1 11045.2 11251.2 11041.8 11048.8 11099.4 11199.9 11221.7 8056.6 8201.8 8243.6 8330.8 8511.7 9757.3 10545.6 10644.8 11129.6 11166.6 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | [#3] mootools.html Cycles:180 Average:5544.34 Median:5232.80 stddev:3019.80 (57.7%) stddev-sans-first:3013.88 20:28:27 INFO - PROCESS | 2247 | Values: 1621.4 1643.0 1879.1 1884.5 1913.9 7728.6 8191.8 8210.8 8549.1 8605.5 8202.2 8231.3 8324.7 8337.3 8343.9 2388.5 2408.7 2430.7 2432.9 2434.5 2386.8 2415.1 2425.3 2429.8 2435.3 2408.6 2420.2 2424.6 2436.8 2439.7 2391.1 2391.8 2401.4 2403.5 2416.6 2034.2 2386.0 2404.2 2410.4 2419.9 8332.0 8403.3 8460.5 8478.7 8480.1 4704.7 4860.4 4992.9 5196.6 5225.8 3398.4 3463.9 3537.4 3572.1 3595.2 1040.9 1049.0 1050.5 1050.7 1051.9 10969.5 10980.3 11031.9 11048.1 11072.9 4633.4 4675.4 4784.4 4786.5 4793.8 9472.7 9552.5 9574.5 9598.0 9614.5 5206.2 5236.0 5292.3 5312.2 5354.2 3920.5 4316.2 4679.5 4819.8 4841.3 3796.1 3825.7 3898.6 3923.9 3938.8 1069.0 1108.0 1123.3 1124.8 1171.6 861.8 885.2 902.2 941.8 954.3 5680.2 5920.8 5944.5 5967.1 6014.2 448.9 459.1 464.3 464.5 467.8 3876.2 3973.9 3980.3 4053.4 4076.1 9513.1 9696.8 9892.1 9981.3 10018.5 9832.9 9841.2 9855.3 9906.4 9906.7 7613.4 7640.2 7730.3 7996.2 8103.4 5865.2 5888.2 5942.5 5975.7 5995.2 8148.0 9675.9 9697.8 9723.6 9797.4 9540.8 9786.9 9819.6 9845.3 9946.6 7363.9 7528.2 7619.0 7635.6 7654.1 7981.8 7994.2 8107.7 8112.4 8210.0 7149.2 7445.0 7460.4 7571.5 7600.1 7312.7 7327.5 7360.0 7480.8 7581.6 6344.8 6436.1 6477.1 6494.3 6512.4 4886.9 5115.4 5153.4 5187.5 5206.0 5154.0 5158.4 5182.8 5229.6 5298.7 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | [#4] prototype.html Cycles:180 Average:4754.88 Median:5219.66 stddev:1490.09 (28.5%) stddev-sans-first:1456.53 20:28:27 INFO - PROCESS | 2247 | Values: 314.8 315.1 317.3 324.2 324.4 4718.3 5305.9 5413.0 5435.8 5505.6 4605.9 4665.4 5247.8 5340.8 5371.3 3470.8 3762.6 4129.4 4143.6 4147.0 3234.9 4118.2 4120.5 4122.8 4149.5 3711.3 3881.6 4072.7 4103.5 4131.6 3875.4 4104.2 4106.2 4143.6 4182.4 3003.9 3082.8 3573.8 3601.4 3602.0 4323.0 4491.0 5147.9 5182.6 5232.7 4467.9 4748.3 4761.3 4770.3 4783.4 4974.6 5419.4 5691.6 5701.7 5706.1 3381.7 3970.6 4020.8 4024.0 4030.1 4909.0 5773.0 5928.8 5974.9 6004.6 3420.0 3896.3 4058.9 4091.0 4113.5 3869.4 4160.5 4173.8 4174.7 4183.0 4762.0 4776.8 4780.7 4800.7 4802.7 4149.2 5414.9 5579.0 5787.7 5804.4 1494.1 1515.2 1521.5 1526.8 1527.8 940.0 992.3 997.5 1016.0 1036.2 5616.2 5645.9 5680.8 5717.5 5724.7 5709.0 5907.5 6284.4 6292.8 6297.0 4767.9 5206.6 5435.8 5698.2 5717.6 3285.5 3305.7 3308.3 3331.1 3382.1 5671.9 6363.8 6508.5 6519.7 6566.7 5149.7 6346.7 6385.7 6409.6 6451.8 5395.0 6456.3 6522.8 6538.4 6567.4 5888.2 6283.4 6292.6 6301.4 6316.9 5113.3 5856.1 5936.7 6143.4 6191.0 5407.9 6199.3 6534.0 6549.8 6590.1 3782.4 4304.6 4318.8 4322.6 4396.3 5199.4 6234.3 6253.7 6313.3 6321.4 5638.7 6037.2 6056.6 6071.6 6076.1 4990.9 5367.6 5501.8 5960.2 6013.7 4297.8 4702.8 5914.1 5919.2 5921.5 4975.3 5654.8 5663.2 5663.9 5789.7 5541.4 5552.7 5570.4 5571.8 5638.7 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - PROCESS | 2247 | [#5] yui.html Cycles:180 Average:17873.94 Median:62205.84 stddev:25135.05 (40.4%) stddev-sans-first:25171.81 20:28:27 INFO - PROCESS | 2247 | Values: 525.9 664.4 665.6 676.2 685.0 14922.5 14968.5 15000.3 15074.3 15134.0 13775.1 13782.5 13839.9 13851.0 13885.7 717.9 878.6 895.5 913.1 915.1 901.3 905.9 911.3 916.5 916.7 839.4 943.4 963.7 965.8 969.2 949.7 954.9 956.9 958.0 958.1 715.9 723.0 725.1 725.7 726.2 14447.3 14640.9 14707.0 14723.1 14779.9 12320.4 12539.2 12586.6 12625.7 12780.0 9722.7 10039.9 10041.5 10294.1 10424.3 3402.1 3446.6 3447.6 3454.7 3476.1 82381.6 83362.6 84808.0 84913.0 85780.0 9411.8 9446.3 9467.1 9564.1 9677.8 20375.8 20538.2 20962.7 21147.8 21213.6 7556.9 7589.9 7674.2 7761.8 7827.2 3698.9 4147.0 4185.1 4205.8 4238.2 3441.6 3476.0 3550.2 3553.0 3560.5 647.9 648.9 649.3 651.4 655.8 523.2 565.2 569.8 589.7 589.8 7129.6 7470.3 7980.1 7991.2 8310.9 536.3 546.1 565.5 589.6 597.9 3579.3 3819.6 3861.2 3985.2 4025.0 89870.0 90598.5 91272.5 94953.5 97303.5 64372.7 74980.6 75743.5 78259.0 78812.6 63277.7 64304.4 65085.7 65733.0 68519.3 7324.5 7559.4 7723.7 7729.3 8247.1 41613.8 44484.8 44502.7 44580.3 44633.3 61657.0 62754.7 63573.4 65681.3 66486.3 11107.2 11127.4 11282.6 11337.7 11547.8 11832.5 11922.6 12259.1 12381.6 12452.0 11451.8 11558.7 11708.4 11773.1 11881.0 11339.9 11634.4 11823.5 11834.4 12196.0 10328.2 11165.5 11349.3 11388.1 11665.8 7810.8 9592.3 9666.7 9859.7 9925.3 9552.1 9666.8 9724.1 9801.9 9829.0 20:28:27 INFO - PROCESS | 2247 | -------- Summary: end -------- 20:28:27 INFO - PROCESS | 2247 | 20:28:27 INFO - TEST-INFO | 2247: exit 0 20:28:27 INFO - TEST-OK | dromaeo_css | took 1111630ms 20:28:27 INFO - TEST-START | kraken 20:28:27 INFO - operating with platform_type : mac_ 20:28:27 INFO - Initialising browser for kraken test... 20:28:27 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpqC0HQ6/profile http://localhost:51399/getInfo.html) 20:28:30 INFO - PROCESS | 2250 | __metrics Screen width/height:1600/1200 20:28:30 INFO - PROCESS | 2250 | colorDepth:24 20:28:30 INFO - PROCESS | 2250 | Browser inner width/height: 1024/689 20:28:30 INFO - PROCESS | 2250 | __metrics 20:28:30 ERROR - PROCESS | 2250 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:28:31 INFO - TEST-INFO | 2250: exit 0 20:28:31 INFO - Browser initialized. 20:28:31 INFO - Running cycle 1/1 for kraken test... 20:28:31 INFO - TEST-INFO | started process 2253 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpqC0HQ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:43 INFO - PROCESS | 2253 | RSS: Main: 250052608 20:28:43 INFO - PROCESS | 2253 | 20:28:46 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51399/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:47 INFO - PROCESS | 2253 | RSS: Main: 262234112 20:28:47 INFO - PROCESS | 2253 | 20:28:50 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51399/tests/kraken/driver.html?testName=audio-dft) 20:28:50 INFO - PROCESS | 2253 | RSS: Main: 271613952 20:28:50 INFO - PROCESS | 2253 | 20:28:54 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51399/tests/kraken/driver.html?testName=audio-fft) 20:28:54 INFO - PROCESS | 2253 | RSS: Main: 274325504 20:28:54 INFO - PROCESS | 2253 | 20:28:56 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51399/tests/kraken/driver.html?testName=audio-oscillator) 20:28:57 INFO - PROCESS | 2253 | RSS: Main: 275742720 20:28:57 INFO - PROCESS | 2253 | 20:28:59 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:00 INFO - PROCESS | 2253 | RSS: Main: 276742144 20:29:00 INFO - PROCESS | 2253 | 20:29:02 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51399/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:03 INFO - PROCESS | 2253 | RSS: Main: 275566592 20:29:03 INFO - PROCESS | 2253 | 20:29:06 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51399/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:07 INFO - PROCESS | 2253 | RSS: Main: 277028864 20:29:07 INFO - PROCESS | 2253 | 20:29:10 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51399/tests/kraken/driver.html?testName=json-parse-financial) 20:29:10 INFO - PROCESS | 2253 | RSS: Main: 277299200 20:29:10 INFO - PROCESS | 2253 | 20:29:12 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:13 INFO - PROCESS | 2253 | RSS: Main: 277012480 20:29:13 INFO - PROCESS | 2253 | 20:29:14 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:15 INFO - PROCESS | 2253 | RSS: Main: 277106688 20:29:15 INFO - PROCESS | 2253 | 20:29:17 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:18 INFO - PROCESS | 2253 | RSS: Main: 278003712 20:29:18 INFO - PROCESS | 2253 | 20:29:21 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:21 INFO - PROCESS | 2253 | RSS: Main: 277590016 20:29:21 INFO - PROCESS | 2253 | 20:29:24 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:25 INFO - PROCESS | 2253 | RSS: Main: 277577728 20:29:25 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:51399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51399/tests/kraken/driver.html?testName=ai-astar) 20:29:27 INFO - PROCESS | 2253 | RSS: Main: 279293952 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | __start_tp_report 20:29:27 INFO - PROCESS | 2253 | _x_x_mozilla_page_load 20:29:27 INFO - PROCESS | 2253 | _x_x_mozilla_page_load_details 20:29:27 INFO - PROCESS | 2253 | |i|pagename|runs| 20:29:27 INFO - PROCESS | 2253 | |0;ai-astar;116;113;117;113;116;129;116;119;116;142 20:29:27 INFO - PROCESS | 2253 | |1;audio-beat-detection;188;154;181;171;124;159;143;125;177;124 20:29:27 INFO - PROCESS | 2253 | |2;audio-dft;199;213;232;251;198;205;195;200;199;197 20:29:27 INFO - PROCESS | 2253 | |3;audio-fft;65;88;73;148;58;57;58;60;130;56 20:29:27 INFO - PROCESS | 2253 | |4;audio-oscillator;79;83;138;78;80;82;161;118;119;111 20:29:27 INFO - PROCESS | 2253 | |5;imaging-gaussian-blur;135;132;90;87;110;93;91;87;90;87 20:29:27 INFO - PROCESS | 2253 | |6;imaging-darkroom;150;111;95;97;103;94;101;142;151;97 20:29:27 INFO - PROCESS | 2253 | |7;imaging-desaturate;99;93;87;92;91;92;91;91;92;91 20:29:27 INFO - PROCESS | 2253 | |8;json-parse-financial;59;63;60;59;60;62;61;81;62;58 20:29:27 INFO - PROCESS | 2253 | |9;json-stringify-tinderbox;65;67;68;67;73;79;72;72;67;67 20:29:27 INFO - PROCESS | 2253 | |10;stanford-crypto-aes;82;85;83;83;85;82;86;85;87;83 20:29:27 INFO - PROCESS | 2253 | |11;stanford-crypto-ccm;154;168;139;138;141;139;137;141;170;161 20:29:27 INFO - PROCESS | 2253 | |12;stanford-crypto-pbkdf2;173;176;175;174;174;173;179;187;172;166 20:29:27 INFO - PROCESS | 2253 | |13;stanford-crypto-sha256-iterative;71;71;72;68;71;68;69;71;66;69 20:29:27 INFO - PROCESS | 2253 | __end_tp_report 20:29:27 INFO - PROCESS | 2253 | __start_cc_report 20:29:27 INFO - PROCESS | 2253 | _x_x_mozilla_cycle_collect,1122 20:29:27 INFO - PROCESS | 2253 | __end_cc_report 20:29:27 INFO - PROCESS | 2253 | __startTimestamp1461641367342__endTimestamp 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | ------- Summary: start ------- 20:29:27 INFO - PROCESS | 2253 | Number of tests: 14 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#0] ai-astar Cycles:10 Average:119.70 Median:116.50 stddev:9.04 (7.8%) stddev-sans-first:9.49 20:29:27 INFO - PROCESS | 2253 | Values: 116.0 113.0 117.0 113.0 116.0 129.0 116.0 119.0 116.0 142.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:165.00 stddev:24.69 (15.0%) stddev-sans-first:23.04 20:29:27 INFO - PROCESS | 2253 | Values: 188.0 154.0 181.0 171.0 124.0 159.0 143.0 125.0 177.0 124.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#2] audio-dft Cycles:10 Average:208.90 Median:202.50 stddev:18.46 (9.1%) stddev-sans-first:19.23 20:29:27 INFO - PROCESS | 2253 | Values: 199.0 213.0 232.0 251.0 198.0 205.0 195.0 200.0 199.0 197.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#3] audio-fft Cycles:10 Average:79.30 Median:59.00 stddev:33.22 (56.3%) stddev-sans-first:34.83 20:29:27 INFO - PROCESS | 2253 | Values: 65.0 88.0 73.0 148.0 58.0 57.0 58.0 60.0 130.0 56.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:78.50 stddev:29.19 (37.2%) stddev-sans-first:29.42 20:29:27 INFO - PROCESS | 2253 | Values: 79.0 83.0 138.0 78.0 80.0 82.0 161.0 118.0 119.0 111.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#5] imaging-gaussian-blur Cycles:10 Average:100.20 Median:88.50 stddev:18.81 (21.3%) stddev-sans-first:15.17 20:29:27 INFO - PROCESS | 2253 | Values: 135.0 132.0 90.0 87.0 110.0 93.0 91.0 87.0 90.0 87.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#6] imaging-darkroom Cycles:10 Average:114.10 Median:122.50 stddev:23.77 (19.4%) stddev-sans-first:21.37 20:29:27 INFO - PROCESS | 2253 | Values: 150.0 111.0 95.0 97.0 103.0 94.0 101.0 142.0 151.0 97.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:92.00 stddev:2.96 (3.2%) stddev-sans-first:1.69 20:29:27 INFO - PROCESS | 2253 | Values: 99.0 93.0 87.0 92.0 91.0 92.0 91.0 91.0 92.0 91.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:61.50 stddev:6.69 (10.9%) stddev-sans-first:6.97 20:29:27 INFO - PROCESS | 2253 | Values: 59.0 63.0 60.0 59.0 60.0 62.0 61.0 81.0 62.0 58.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:4.24 (6.1%) stddev-sans-first:4.15 20:29:27 INFO - PROCESS | 2253 | Values: 65.0 67.0 68.0 67.0 73.0 79.0 72.0 72.0 67.0 67.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:85.00 stddev:1.73 (2.0%) stddev-sans-first:1.66 20:29:27 INFO - PROCESS | 2253 | Values: 82.0 85.0 83.0 83.0 85.0 82.0 86.0 85.0 87.0 83.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:147.50 stddev:13.18 (8.9%) stddev-sans-first:13.85 20:29:27 INFO - PROCESS | 2253 | Values: 154.0 168.0 139.0 138.0 141.0 139.0 137.0 141.0 170.0 161.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.50 stddev:5.38 (3.1%) stddev-sans-first:5.67 20:29:27 INFO - PROCESS | 2253 | Values: 173.0 176.0 175.0 174.0 174.0 173.0 179.0 187.0 172.0 166.0 20:29:27 INFO - PROCESS | 2253 | 20:29:27 INFO - PROCESS | 2253 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:71.00 stddev:1.90 (2.7%) stddev-sans-first:1.94 20:29:27 INFO - PROCESS | 2253 | Values: 71.0 71.0 72.0 68.0 71.0 68.0 69.0 71.0 66.0 69.0 20:29:27 INFO - PROCESS | 2253 | -------- Summary: end -------- 20:29:27 INFO - PROCESS | 2253 | 20:29:28 INFO - TEST-INFO | 2253: exit 0 20:29:28 INFO - TEST-OK | kraken | took 60215ms 20:29:28 INFO - SUITE-END | took 1171s 20:29:28 INFO - Completed test suite (00:19:32) 20:29:28 INFO - javascript benchmark 20:29:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3448.1552019755154, 3458.481227815828, 3494.6680065393793, 3506.929861402772, 3530.6116327204018, 5553.6948817028015, 5686.431356864311, 5732.627379220347, 5749.482546570808, 5763.654180749158, 5645.8588535286635, 5744.827655170341, 5749.56878234132, 5796.884062318762, 5848.795292164775, 5148.794048238075, 5153.510416510426, 5188.558972487343, 5189.169732842746, 5230.947690523084, 315.0804979852916, 5199.09015922214, 5212.687238765668, 5241.39723931747, 5278.47215278473, 4262.381954616563, 5164.096283150452, 5169.914317993226, 5199.116150254447, 5215.608829337815, 4213.662906967435, 5027.899442011176, 5108.616853735947, 5215.0, 5314.012059254105, 3847.8648798604477, 4624.722516648978, 5132.794688212467, 5145.742712864379, 5197.506236907488, 4483.663725220622, 4563.657725670555, 4588.4723256825555, 5713.257276554063, 5716.485516303511, 6127.0, 6174.413430724074, 6208.87582248357, 6249.625022498664, 6276.686165691697, 6226.2839773426185, 6227.3772622737815, 6243.500519958392, 6261.7182226799905, 6283.403076707706, 5836.708164591753, 5857.150713146612, 5867.765289388462, 5870.589058765888, 5900.734466948998, 6210.099535567408, 6261.279952805395, 6265.937340626535, 6345.365463453618, 6349.142865713162, 6179.16581261533, 6183.319834818167, 6194.318624951252, 6198.845028874314, 6207.099970504251, 6190.350013248544, 6220.315765265817, 6246.250449945945, 6257.655828929362, 6269.965455699849, 6109.358517355614, 6144.095330447575, 6192.885280649526, 6219.533534984804, 6272.027835685476, 6104.732011601605, 6135.754569817246, 6230.0, 6270.592411493239, 6275.717592708339, 4049.190161967618, 4969.950300497021, 4972.403311602631, 5031.647784655039, 5033.345665063518, 3350.329934013207, 3938.0548668319398, 4311.568843115726, 4378.80295386702, 4466.709663871838, 5608.6073974821375, 5724.8282551523525, 5812.970935145382, 5823.417658234142, 5885.058390657474, 6252.280987686474, 6259.998400256029, 6275.843103922347, 6281.120643109968, 6345.33373995733, 4578.679492435497, 5689.402612725687, 5824.213731146241, 5846.853828654318, 5917.112473089303, 5405.78376864921, 5440.0, 5442.129259318569, 5442.6462279951675, 5475.370332411823, 6204.286507051746, 6396.0, 6399.776007839796, 6408.679566021773, 6431.646259455775, 6151.84620384494, 6213.130161777445, 6240.687965601793, 6244.406781355764, 6247.375262473716, 6362.968185159045, 6399.456046235936, 6401.071844582416, 6407.0709747085475, 6416.518761092843, 6046.395360463918, 6132.20254427538, 6235.3452887446165, 6238.781642642486, 6240.500759939285, 6151.477124444473, 6176.598521096114, 6228.0969259456215, 6253.624782513064, 6257.4681152102585, 5228.0, 6103.870783904992, 6148.4466398022605, 6171.907421388593, 6193.907091393543, 6043.456088952015, 6113.57204995646, 6124.472479235402, 6138.07928810682, 6147.354527774698, 5769.769209231584, 5857.970710146422, 5926.140709596998, 5985.730642121028, 5989.610675306091, 6148.47737942262, 6157.415045570664, 6183.288921774054, 6183.412575805291, 6204.875902482016, 5824.767009319579, 5962.4633782959745, 6022.0, 6029.849253768691, 6087.878242435215], "value": 5614.930800419598, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.2427963817169, 501.4484067525721, 537.7311344327836, 599.9940000599994, 625.6527627166923, 38772.80613596932, 39281.214375712465, 39412.40881386781, 39493.012674683145, 39543.209135817306, 40176.39735403971, 40294.19411611766, 40911.38632920509, 40944.771656850266, 41004.79497602508, 9363.344565880374, 9542.188913942324, 9607.991160928106, 9646.324757266993, 9658.03419658032, 9471.147596716328, 9552.283578731589, 9663.371880827759, 9700.078492543196, 9726.221902247838, 9686.273529485281, 9696.51517424126, 9775.169110625606, 9788.119069283763, 9791.853122203138, 8238.423310368276, 9658.75853103671, 9732.270079744048, 9753.707388778348, 9754.609815607368, 8304.335653147795, 9569.90430095697, 9640.517974101267, 9725.221982241474, 9728.0, 39211.8039409804, 39447.01382465433, 39640.405393919114, 39808.0, 39989.60010399917, 2750.546159883637, 2793.5669971154302, 3092.2887735820664, 3189.9043028708943, 3268.7221586165206, 22887.198948036737, 26383.208503744918, 27585.380227946964, 27794.0, 28113.437731245464, 2673.3183038325296, 2677.919662410131, 2722.8366298022183, 2865.8423786691724, 2912.9708702912912, 377872.0, 380415.0, 381501.0, 381595.0, 381765.0, 62414.68792656008, 62635.68682156651, 62664.0, 62735.372646272954, 62882.0, 61828.69085654543, 62363.37636623666, 62997.0, 63210.73578528496, 63227.36772632215, 14010.719785604231, 16900.492985210218, 17184.656306874043, 17192.484225473258, 17304.826951730323, 13048.673783155307, 13055.412506437233, 13104.148230364995, 13133.212007279593, 13138.671533211555, 17292.654146917244, 19275.51811204703, 19800.0, 19874.801251987585, 20231.291904783262, 7049.964750176319, 8269.46248493846, 8399.538025408661, 8405.511712639309, 8438.66245350179, 903.6566104880103, 926.3746970794687, 1010.8180527505119, 1013.2704452793977, 1058.4599407861697, 26477.47045059088, 30087.0, 30212.54681179784, 30375.848120759696, 30659.8467007668, 1048.2714513413257, 1049.803224324271, 1109.4674556213063, 1146.5471138900089, 1195.8146487294484, 15343.0, 15508.612284692746, 15694.9215253923, 15746.606334841492, 15872.353945748386, 661213.0, 662785.0, 664701.0, 673058.0, 676140.0, 53915.19127213095, 58168.0, 60778.0, 61138.0, 61218.0, 1417.121384741467, 1443.0620096937075, 1454.2219912346843, 1465.4905447389206, 1470.4926800253681, 27955.881764729183, 28043.298917527223, 28426.147215583565, 28700.0, 28910.421791564473, 52371.0, 52550.47449525456, 52615.0, 52840.0, 54512.72743636256, 627071.0, 627185.0, 632923.8353808201, 635143.0, 637252.0, 38170.23659526849, 42642.933926652084, 43211.56788432076, 43262.78368608137, 43270.567294326655, 42574.0, 42761.0, 43033.99897948637, 43343.78328108339, 43682.563174367846, 35608.46587301244, 35991.460128098624, 36235.0, 36382.8180859094, 36988.81505592455, 35572.110697232776, 36052.694230616034, 36236.81881590575, 37240.88277351684, 38328.0, 36689.0, 37240.627593723715, 37359.87920362393, 37377.0, 37464.812675936446, 29840.70159298466, 32623.0, 33100.83449582737, 33651.3269734599, 33705.49441758425, 24582.631260531463, 24623.876880615484, 24682.765861706484, 25110.874445628386, 25112.62331065072], "value": 19943.743523836376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.80482941626235, 371.67478456350693, 393.16060211448564, 405.89852536865783, 410.5996653263067, 15071.095734255925, 18061.458156255318, 18368.540786480346, 19833.603327933433, 22251.0, 19457.708134377997, 20023.39812814975, 20080.0, 21444.57110857782, 21980.89009554954, 5155.613329000321, 5769.1346298055205, 5887.793927212538, 5973.4623883850445, 6068.453839154476, 5159.4324624291485, 5831.329397119322, 5916.88166236675, 5954.910676339859, 5979.1330257112695, 5573.944260557403, 5914.053751399777, 5932.762689492437, 5942.702864856761, 5943.286805583336, 5825.796097136601, 5846.444587764156, 5851.824445266649, 5920.585559010871, 6006.609570377956, 5754.395788442237, 5797.768089276424, 5837.657338812054, 5840.795572154997, 5871.295444546639, 13369.264690442022, 15063.472778452811, 21794.673079903812, 24397.634035489304, 25170.87414562934, 2035.9796402035938, 2107.1571371451387, 2404.471016376412, 2539.593665013589, 2718.9320266993286, 9978.501074946296, 10156.441395723232, 10190.694279171637, 10263.79472410555, 10288.176945844314, 1739.6346767178907, 1778.9644207115914, 1820.29008686611, 1838.8231531819647, 1842.1802297977406, 105281.94718052875, 110236.0, 110533.44733276362, 110994.0, 111452.0, 11314.943425282985, 11532.88467115335, 11652.592159274385, 11817.468213930393, 11833.644990650295, 13484.595462136152, 13811.378487968066, 14295.642608934651, 15173.62065948338, 15263.923680381527, 6977.023216749659, 8356.707515236938, 8799.604017819214, 8842.292616590657, 8849.51327676971, 8613.138686131337, 8635.611397487128, 8638.913610863936, 8641.265492433213, 8713.346499012472, 4616.884577885579, 4675.625949923998, 4703.106409782131, 4751.239801631722, 4782.95217047832, 1931.9830653336226, 1957.0703915639956, 2018.9192432302837, 2025.665765148734, 2033.2680235115347, 703.8733028055, 958.2334132693817, 963.8000689142063, 986.6250824686573, 1043.4521876015153, 15208.695826083416, 20369.08339124743, 20717.482062948246, 21314.254001109886, 21391.930403479764, 866.7139843851514, 869.9826003479895, 931.8182954323977, 943.1843700875787, 1019.6686077024997, 10879.456027198608, 11093.83359249612, 11153.103972324725, 11154.386508742096, 11220.943895280634, 642496.0, 649131.0, 666095.646677643, 668462.0, 671127.0, 89029.0, 99917.0, 113372.43313783543, 118656.0, 123854.0, 985.7190700650281, 1001.1540248490014, 1002.8545860850281, 1019.7705516258783, 1056.0442799266675, 17842.0, 18085.276588936296, 18153.0, 18181.363652272106, 18475.353362632242, 29611.96358127455, 41195.70434365304, 43792.34311485394, 46265.76867115643, 47183.528164717914, 50574.0, 55955.0, 60291.625635462675, 65290.0, 72126.27873721195, 7652.464327497022, 7861.960690196513, 7896.526208427513, 8027.518348899085, 8253.257206851413, 10871.945640271748, 12347.259164450163, 12462.563810266598, 12713.80929286043, 12788.808167877676, 7947.245011723877, 10705.839412408975, 10880.347179169275, 10884.455777211266, 11123.888761112285, 8595.87106193395, 10719.839202411815, 10925.065321020506, 11045.171612129283, 11251.212415130862, 11041.779164416826, 11048.834267486154, 11099.445027748741, 11199.944000279946, 11221.66335009951, 8056.637451314587, 8201.79495512617, 8243.629036693243, 8330.750077497685, 8511.702090426805, 9757.26820488452, 10545.630902918361, 10644.787104258026, 11129.55481780752, 11166.553337866395], "value": 9292.327507999342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1621.4324986254812, 1643.038822288961, 1879.0510792050013, 1884.5288677830542, 1913.9043047847604, 7728.613569321526, 8191.836163276731, 8210.794730131742, 8549.102344253857, 8605.526696031715, 8202.220789025034, 8231.259186673198, 8324.667013319475, 8337.333013358932, 8343.874841877361, 2388.4984153327823, 2408.7350391456926, 2430.744771798962, 2432.8783560821976, 2434.513097380522, 2386.8209884258663, 2415.118481754165, 2425.320910145162, 2429.7813196812285, 2435.330284171849, 2408.5664580375524, 2420.201333559921, 2424.5635785558593, 2436.8181432005463, 2439.6828412306377, 2391.0794344177443, 2391.7608239176116, 2401.435662619283, 2403.483251101013, 2416.6254230594286, 2034.2473284884688, 2386.0455817672896, 2404.1825779235146, 2410.3612542676206, 2419.8911049002663, 8332.0, 8403.327733781283, 8460.450070745383, 8478.66085356585, 8480.067192608809, 4704.741239231841, 4860.392450943632, 4992.925106123411, 5196.610254230948, 5225.764840582183, 3398.3543126806076, 3463.913402164966, 3537.4163263061564, 3572.1248294167835, 3595.1551385424405, 1040.881805525759, 1048.958041678332, 1050.5010120192924, 1050.7110544600296, 1051.894810518942, 10969.506372213269, 10980.341179529254, 11031.889681103166, 11048.116150707923, 11072.889271107266, 4633.397658304466, 4675.4155730533685, 4784.378030856036, 4786.521347865255, 4793.808247670054, 9472.668456603986, 9552.471604543378, 9574.47340396271, 9598.040195980346, 9614.471204083702, 5206.167013277933, 5236.0, 5292.259083728281, 5312.1766126250495, 5354.170103633943, 3920.4707364506, 4316.179925814085, 4679.532046795293, 4819.759012049383, 4841.273808928689, 3796.126890815128, 3825.713071519647, 3898.6491215790147, 3923.9215215695526, 3938.7636741795586, 1068.9893101069044, 1107.9612213572648, 1123.337231033694, 1124.848145500347, 1171.6250799744, 861.8448679237797, 885.2342723544087, 902.1519771414848, 941.75985123793, 954.3224310739453, 5680.233168522197, 5920.792772253037, 5944.464998150101, 5967.104934259895, 6014.218151640259, 448.88104652267174, 459.07954551124783, 464.2641413359795, 464.47746285428894, 467.8035225205422, 3876.1666241758157, 3973.900652483711, 3980.283548961215, 4053.3919912012843, 4076.1032572834524, 9513.143817056498, 9696.75758106053, 9892.109710125978, 9981.251406144424, 10018.549165287579, 9832.852507212398, 9841.163501102486, 9855.31012829095, 9906.405615663083, 9906.653267135616, 7613.352865006536, 7640.197779233212, 7730.342920851791, 7996.200379961957, 8103.351731861437, 5865.208196893364, 5888.234529511307, 5942.465178133989, 5975.701214939322, 5995.190649262294, 8147.959260203661, 9675.903240967782, 9697.806043879224, 9723.611055557698, 9797.412155270707, 9540.809183816145, 9786.853197201905, 9819.607215711578, 9845.261605379768, 9946.602135914482, 7363.889541656772, 7528.247175282428, 7619.0, 7635.618219089134, 7654.081510218809, 7981.760547183594, 7994.2405471480115, 8107.716229931924, 8112.432129751097, 8210.01479822425, 7149.249328820607, 7444.99492568518, 7460.403167746459, 7571.507851989603, 7600.087989441303, 7312.670929808065, 7327.523710958771, 7360.0, 7480.775576732707, 7581.6209189541405, 6344.809655710336, 6436.13112229843, 6477.093206951125, 6494.285628580947, 6512.446442052289, 4886.877828054327, 5115.360579927509, 5153.433122356612, 5187.533122019036, 5206.0368831766245, 5153.974230128825, 5158.446568948395, 5182.844514664566, 5229.607779416635, 5298.682079075268], "value": 4428.99074202747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.81740590457537, 315.1302405361203, 317.2591997685403, 324.2234847540143, 324.39338437122586, 4718.343283954937, 5305.920411193835, 5413.0, 5435.755391007404, 5505.587080968929, 4605.894585299529, 4665.393498845146, 5247.795925711201, 5340.786368545254, 5371.328583927009, 3470.77439966402, 3762.604926482721, 4129.442525259082, 4143.606357396043, 4146.958530414688, 3234.8973167441236, 4118.238125946695, 4120.484939382577, 4122.814473348706, 4149.460570125894, 3711.294853977749, 3881.592432794558, 4072.6538244249273, 4103.5280942691525, 4131.566185550519, 3875.379939209741, 4104.220198162339, 4106.240345536085, 4143.647789937859, 4182.393552934838, 3003.9035751950382, 3082.828525160447, 3573.767050367619, 3601.4237721964623, 3602.0094474019593, 4322.978385108086, 4491.011977364975, 5147.944671342366, 5182.585393168538, 5232.73836308183, 4467.865964021084, 4748.264019077014, 4761.26200438929, 4770.260609605517, 4783.378160839104, 4974.552290293891, 5419.430959749209, 5691.589018510646, 5701.6864072476, 5706.058500347438, 3381.661833816623, 3970.5830887756947, 4020.839166433339, 4024.0, 4030.052937559671, 4908.950910490921, 5773.0, 5928.822135335947, 5974.940250597482, 6004.5796794224425, 3420.0, 3896.279188350164, 4058.8838069531116, 4091.018155642624, 4113.547509773923, 3869.400242962289, 4160.521540022936, 4173.791310434466, 4174.666026717916, 4183.0, 4761.976190119097, 4776.761161941889, 4780.665353425296, 4800.73595952226, 4802.73584952824, 4149.211649786531, 5414.891702166014, 5579.0, 5787.652740835563, 5804.390538993429, 1494.0886059503694, 1515.1515151515187, 1521.4979056911193, 1526.8167819861687, 1527.823575846592, 939.957701903416, 992.3450522655013, 997.486294558303, 1015.9593616255415, 1036.1969473657975, 5616.213730077792, 5645.858853528613, 5680.77276908919, 5717.485426311652, 5724.713764311768, 5709.029464990961, 5907.4683278505145, 6284.37156284377, 6292.766068045869, 6297.0, 4767.903382222039, 5206.583473322125, 5435.83692489226, 5698.176583493242, 5717.627769335413, 3285.5071739239306, 3305.669433056675, 3308.2556424804707, 3331.0506505645776, 3382.1375549234785, 5671.8865622688145, 6363.7772677956045, 6508.479321654257, 6519.696060787766, 6566.67166641666, 5149.6910185389, 6346.68346053687, 6385.744570217233, 6409.551331406757, 6451.774187903401, 5395.030813752874, 6456.322086180883, 6522.771702990467, 6538.378854008862, 6567.3760992706575, 5888.175655408332, 6283.434490895658, 6292.590981586182, 6301.38492525615, 6316.936830631635, 5113.284140220447, 5856.092305692625, 5936.673482958478, 6143.447089761943, 6190.969045154746, 5407.864803379947, 6199.287081985449, 6533.967330163509, 6549.803505894831, 6590.143281373391, 3782.432635104756, 4304.634106101016, 4318.762468064287, 4322.632576231055, 4396.296592545177, 5199.376074871039, 6234.2830574482705, 6253.687315634109, 6313.305536390902, 6321.4196450887275, 5638.661680299195, 6037.1927053920135, 6056.636601803906, 6071.630245213949, 6076.118962750465, 4990.925136123034, 5367.624266301322, 5501.834944951658, 5960.225170727777, 6013.7293821779, 4297.806598703003, 4702.835400760957, 5914.142449344907, 5919.230500034968, 5921.467067963904, 4975.303457515878, 5654.802081927113, 5663.2071509989455, 5663.85840353978, 5789.739461724317, 5541.418151094077, 5552.7223638818705, 5570.387257401763, 5571.777128914798, 5638.6898720569125], "value": 4295.399118845115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.9368875734912, 664.4219529009762, 665.6172700697099, 676.2358534855613, 685.0101603183402, 14922.477713280025, 14968.476103336372, 15000.324985375657, 15074.321655525486, 15134.016288941211, 13775.10461819981, 13782.517611883586, 13839.861601383984, 13851.0, 13885.652858678539, 717.8779607466718, 878.6178012564523, 895.4537731983469, 913.1234015345276, 915.1169121797465, 901.3104974694364, 905.8867641544807, 911.3028533172129, 916.505087252886, 916.6837441082849, 839.4459656626627, 943.4292253186826, 963.6771681486675, 965.7971825916566, 969.2343048991288, 949.710338346804, 954.9092836180552, 956.9282303827206, 958.0132463562542, 958.0850287974968, 715.9391451726609, 722.9746958856415, 725.1226016520017, 725.7459889038847, 726.1975517053633, 14447.277636118257, 14640.90193235501, 14707.0, 14723.116613003254, 14779.926100369537, 12320.445579948924, 12539.24764514123, 12586.622401327975, 12625.684357891034, 12780.04149688777, 9722.708318750449, 10039.89960100397, 10041.497925103715, 10294.124999375063, 10424.322419042737, 3402.0644322811177, 3446.5691788526433, 3447.5518182636347, 3454.671806178409, 3476.1135910342955, 82381.58809205976, 83362.58318708367, 84808.0, 84913.0, 85779.99999999937, 9411.764705882271, 9446.291528135418, 9467.147956683793, 9564.091411315914, 9677.806443871083, 20375.79624203739, 20538.17847286122, 20962.685559716618, 21147.78852211489, 21213.575728485343, 7556.886646700304, 7589.924100759032, 7674.232576742281, 7761.7671469855995, 7827.217278272127, 3698.9075273118387, 4147.0461793787, 4185.100203456272, 4205.810738516774, 4238.23711731885, 3441.6214216436174, 3475.982620086934, 3550.183457804668, 3552.982235088808, 3560.537130173061, 647.870425914819, 648.9026646003043, 649.2695717318018, 651.3616655677463, 655.8031592343991, 523.2151772341488, 565.21435205065, 569.7550053477045, 589.6609449566516, 589.8289496046184, 7129.643517824088, 7470.2903224193615, 7980.122186559473, 7991.160928102582, 8310.875336869953, 536.2813829468531, 546.0716781471515, 565.5164834066813, 589.590234786819, 597.8893904627657, 3579.266250418658, 3819.560750513671, 3861.1505468796818, 3985.1830374773103, 4024.9798751006642, 89870.0, 90598.54700726454, 91272.54363728139, 94953.5252323734, 97303.51348243213, 64372.678136609014, 74980.62509687417, 75743.48513029708, 78259.0, 78812.60593696995, 63277.68361158165, 64304.35695643077, 65085.67457162779, 65733.0, 68519.28701782395, 7324.523905946096, 7559.357454616419, 7723.729669461542, 7729.3430058445665, 8247.134050924567, 41613.79193104015, 44484.77757611191, 44502.65968083851, 44580.33129502995, 44633.33050004188, 61657.0, 62754.68622656858, 63573.364266356744, 65681.34318656752, 66486.33513664996, 11107.222494425312, 11127.443627818415, 11282.605108821152, 11337.716557086138, 11547.826782598437, 11832.467538960595, 11922.642320730392, 12259.141860069709, 12381.62855114348, 12452.0, 11451.770964580495, 11558.653240402802, 11708.414579270831, 11773.117016223989, 11881.0, 11339.943300283447, 11634.418279085843, 11823.527058917547, 11834.407906200717, 12196.024318054357, 10328.173746100445, 11165.49755260999, 11349.319040857576, 11388.145889058189, 11665.825012624988, 7810.804729881798, 9592.280578956746, 9666.661666841908, 9859.65491207833, 9925.305228633926, 9552.092551207625, 9666.75833104178, 9724.076212759777, 9801.85297220528, 9829.0], "value": 6805.637828308557, "unit": "score"}], "name": "dromaeo_css", "value": 7160.053545720923, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 117.0, 113.0, 116.0, 129.0, 116.0, 119.0, 116.0, 142.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 154.0, 181.0, 171.0, 124.0, 159.0, 143.0, 125.0, 177.0, 124.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 213.0, 232.0, 251.0, 198.0, 205.0, 195.0, 200.0, 199.0, 197.0], "value": 208.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 88.0, 73.0, 148.0, 58.0, 57.0, 58.0, 60.0, 130.0, 56.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 138.0, 78.0, 80.0, 82.0, 161.0, 118.0, 119.0, 111.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 90.0, 87.0, 110.0, 93.0, 91.0, 87.0, 90.0, 87.0], "value": 100.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 111.0, 95.0, 97.0, 103.0, 94.0, 101.0, 142.0, 151.0, 97.0], "value": 114.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 93.0, 87.0, 92.0, 91.0, 92.0, 91.0, 91.0, 92.0, 91.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 60.0, 59.0, 60.0, 62.0, 61.0, 81.0, 62.0, 58.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 67.0, 73.0, 79.0, 72.0, 72.0, 67.0, 67.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 83.0, 83.0, 85.0, 82.0, 86.0, 85.0, 87.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 168.0, 139.0, 138.0, 141.0, 139.0, 137.0, 141.0, 170.0, 161.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 175.0, 174.0, 174.0, 173.0, 179.0, 187.0, 172.0, 166.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 68.0, 71.0, 68.0, 69.0, 71.0, 66.0, 69.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1583.1999999999998, "alertThreshold": 2.0}]} 20:29:28 INFO - Return code: 0 20:29:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:28 ERROR - # TBPL SUCCESS # 20:29:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:28 INFO - 2016-04-25 20:29:28.658 screenresolution[2258:21742] starting screenresolution argv=screenresolution get 20:29:28 INFO - 2016-04-25 20:29:28.661 screenresolution[2258:21742] Display 0: 1600x1200x32@60 20:29:28 INFO - 2016-04-25 20:29:28.667 screenresolution[2259:21745] starting screenresolution argv=screenresolution list 20:29:28 INFO - Available Modes on Display 0 20:29:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:28 INFO - Intel Iris: 20:29:28 INFO - Chipset Model: Intel Iris 20:29:28 INFO - Type: GPU 20:29:28 INFO - Bus: Built-In 20:29:28 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:28 INFO - Vendor: Intel (0x8086) 20:29:28 INFO - Device ID: 0x0a2e 20:29:28 INFO - Revision ID: 0x0009 20:29:28 INFO - Displays: 20:29:28 INFO - Display: 20:29:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:28 INFO - Display Serial Number: 1600x1200 60 20:29:28 INFO - Main Display: Yes 20:29:28 INFO - Mirror: Off 20:29:28 INFO - Online: Yes 20:29:28 INFO - Rotation: Supported 20:29:28 INFO - Return code: 0 20:29:28 INFO - Running post-action listener: _resource_record_post_action 20:29:28 INFO - Running post-run listener: _resource_record_post_run 20:29:29 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 380928; Write bytes: 696408576; Read time: 3; Write time: 2463 20:29:29 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 376101376; Write bytes: 369702400; Read time: 28227; Write time: 648 20:29:29 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 380928; Write bytes: 299308032; Read time: 3; Write time: 1765 20:29:29 INFO - Running post-run listener: _upload_blobber_files 20:29:29 INFO - Blob upload gear active. 20:29:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:29 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 20:29:29 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'] 20:29:29 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 20:29:30 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:31 INFO - (blobuploader) - INFO - Done attempting. 20:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:29:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:32 INFO - (blobuploader) - INFO - Done attempting. 20:29:32 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:32 INFO - Return code: 0 20:29:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b5f97f6016be9263dd446f62aead05be5754b065f6ad8b8ae24bb263407781cb4192b60ec1be8c019e906fe1d5b81079bca36b5c1d60dab78b216c8ef98239", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61f8d51dcd9e93c4c9023a0c4d045386d3720046abe43dc074d9019546dbf701afda37d90b672d621ce43996674bc633f86718521d99d48a26e2d72b293a500"} 20:29:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:32 INFO - Contents: 20:29:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b5f97f6016be9263dd446f62aead05be5754b065f6ad8b8ae24bb263407781cb4192b60ec1be8c019e906fe1d5b81079bca36b5c1d60dab78b216c8ef98239", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61f8d51dcd9e93c4c9023a0c4d045386d3720046abe43dc074d9019546dbf701afda37d90b672d621ce43996674bc633f86718521d99d48a26e2d72b293a500"} 20:29:32 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:32 INFO - Copying logs to upload dir... 20:29:32 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.292331 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-25 20:29:32.174337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 20:29:32.178240) ========= 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.OLlehdlwOY/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.t4OVTqiMMC/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b5f97f6016be9263dd446f62aead05be5754b065f6ad8b8ae24bb263407781cb4192b60ec1be8c019e906fe1d5b81079bca36b5c1d60dab78b216c8ef98239", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61f8d51dcd9e93c4c9023a0c4d045386d3720046abe43dc074d9019546dbf701afda37d90b672d621ce43996674bc633f86718521d99d48a26e2d72b293a500"} build_url:https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011591 build_url: 'https://queue.taskcluster.net/v1/task/VH3hQQR6ScCGcgb5nmH-Tg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1b5f97f6016be9263dd446f62aead05be5754b065f6ad8b8ae24bb263407781cb4192b60ec1be8c019e906fe1d5b81079bca36b5c1d60dab78b216c8ef98239", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61f8d51dcd9e93c4c9023a0c4d045386d3720046abe43dc074d9019546dbf701afda37d90b672d621ce43996674bc633f86718521d99d48a26e2d72b293a500"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 20:29:32.208085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 20:29:32.208520) ========= 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.OLlehdlwOY/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.t4OVTqiMMC/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005369 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 20:29:32.257410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 20:29:32.257714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 20:29:32.258048) ========= ========= Total master_lag: 2.99 =========