builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0283 starttime: 1463736778.96 results: success (0) buildid: 20160520004020 builduid: 5dfe1364884c48b6b304c6cb7a949a07 revision: 9ba18aae69e626a3f83560df321d91e42316083a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:58.962955) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:58.963330) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:58.963620) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:58.984556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:58.984877) ========= 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.WKprgsUmHE/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.BgsEZxOmKU/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-20 02:32:58-- 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% 133M=0s 2016-05-20 02:32:59 (133 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114819 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:59.123075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:59.124655) ========= 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.WKprgsUmHE/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.BgsEZxOmKU/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.025859 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:32:59.173946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 02:32:59.174253) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ba18aae69e626a3f83560df321d91e42316083a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9ba18aae69e626a3f83560df321d91e42316083a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WKprgsUmHE/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.BgsEZxOmKU/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-20 02:32:59,243 truncating revision to first 12 chars 2016-05-20 02:32:59,244 Setting DEBUG logging. 2016-05-20 02:32:59,244 attempt 1/10 2016-05-20 02:32:59,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9ba18aae69e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 02:33:00,693 unpacking tar archive at: mozilla-aurora-9ba18aae69e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.698391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-20 02:33:00.895953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 02:33:00.896274) ========= script_repo_revision: 9ba18aae69e626a3f83560df321d91e42316083a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 02:33:00.896661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 02:33:00.896927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 02:33:00.911738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-20 02:33:00.912006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WKprgsUmHE/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.BgsEZxOmKU/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:01 INFO - MultiFileLogger online at 20160520 02:33:01 in /builds/slave/test 02:33:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:33:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:01 INFO - {'append_to_log': False, 02:33:01 INFO - 'base_work_dir': '/builds/slave/test', 02:33:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:33:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:01 INFO - 'branch': 'Mozilla-Aurora', 02:33:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:01 INFO - 'config_files': ('talos/mac_config.py',), 02:33:01 INFO - 'default_actions': ('clobber', 02:33:01 INFO - 'read-buildbot-config', 02:33:01 INFO - 'download-and-extract', 02:33:01 INFO - 'populate-webroot', 02:33:01 INFO - 'create-virtualenv', 02:33:01 INFO - 'install', 02:33:01 INFO - 'run-tests'), 02:33:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:01 INFO - 'download_minidump_stackwalk': True, 02:33:01 INFO - 'download_symbols': 'ondemand', 02:33:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:01 INFO - 'installer_path': 'installer.exe', 02:33:01 INFO - 'log_level': 'info', 02:33:01 INFO - 'log_name': 'talos', 02:33:01 INFO - 'log_to_console': True, 02:33:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:33:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:33:01 INFO - 'opt_config_files': (), 02:33:01 INFO - 'pip_index': False, 02:33:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:01 INFO - 'cmd': ('bash', 02:33:01 INFO - '-c', 02:33:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:01 INFO - 'enabled': True, 02:33:01 INFO - 'halt_on_failure': False, 02:33:01 INFO - 'name': 'check_screen_resolution'},), 02:33:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:33:01 INFO - 'cmd': ('bash', 02:33:01 INFO - '-c', 02:33:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:33:01 INFO - 'enabled': True, 02:33:01 INFO - 'halt_on_failure': False, 02:33:01 INFO - 'name': 'check_screen_resolution'},), 02:33:01 INFO - 'run_cmd_checks_enabled': True, 02:33:01 INFO - 'sps_profile': False, 02:33:01 INFO - 'sps_profile_interval': 0, 02:33:01 INFO - 'suite': 'dromaeojs-e10s', 02:33:01 INFO - 'system_bits': '32', 02:33:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:01 INFO - 'title': 't-yosemite-r7-0283', 02:33:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:01 INFO - 'use_talos_json': True, 02:33:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:01 INFO - 'work_dir': 'build'} 02:33:01 INFO - ##### 02:33:01 INFO - ##### Running clobber step. 02:33:01 INFO - ##### 02:33:01 INFO - Running pre-action listener: _resource_record_pre_action 02:33:01 INFO - Running main action method: clobber 02:33:01 INFO - rmtree: /builds/slave/test/build 02:33:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:02 INFO - Running post-action listener: _resource_record_post_action 02:33:02 INFO - ##### 02:33:02 INFO - ##### Running read-buildbot-config step. 02:33:02 INFO - ##### 02:33:02 INFO - Running pre-action listener: _resource_record_pre_action 02:33:02 INFO - Running main action method: read_buildbot_config 02:33:02 INFO - Using buildbot properties: 02:33:02 INFO - { 02:33:02 INFO - "project": "", 02:33:02 INFO - "product": "firefox", 02:33:02 INFO - "script_repo_revision": "production", 02:33:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:33:02 INFO - "repository": "", 02:33:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:33:02 INFO - "buildid": "20160520004020", 02:33:02 INFO - "stage_platform": "macosx64", 02:33:02 INFO - "basedir": "/builds/slave/test", 02:33:02 INFO - "nightly_build": "True", 02:33:02 INFO - "buildnumber": 13, 02:33:02 INFO - "slavename": "t-yosemite-r7-0283", 02:33:02 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:33:02 INFO - "platform": "yosemite_r7", 02:33:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:33:02 INFO - "branch": "mozilla-aurora", 02:33:02 INFO - "repo_path": "releases/mozilla-aurora", 02:33:02 INFO - "revision": "9ba18aae69e626a3f83560df321d91e42316083a", 02:33:02 INFO - "pgo_build": "False", 02:33:02 INFO - "builduid": "5dfe1364884c48b6b304c6cb7a949a07", 02:33:02 INFO - "slavebuilddir": "test" 02:33:02 INFO - } 02:33:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 02:33:02 INFO - Running post-action listener: _resource_record_post_action 02:33:02 INFO - ##### 02:33:02 INFO - ##### Running download-and-extract step. 02:33:02 INFO - ##### 02:33:02 INFO - Running pre-action listener: _resource_record_pre_action 02:33:02 INFO - Running main action method: download_and_extract 02:33:02 INFO - mkdir: /builds/slave/test/build/tests 02:33: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')]} 02:33:02 INFO - https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:33:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 02:33:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 02:33:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 02:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 02:33:03 INFO - Downloaded 1199 bytes. 02:33:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 02:33:03 INFO - Using the following test package requirements: 02:33:03 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 02:33:03 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 02:33:03 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 02:33:03 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'jsshell-mac.zip'], 02:33:03 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 02:33:03 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 02:33:03 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 02:33:03 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 02:33:03 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 02:33:03 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:33:03 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 02:33:03 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:03 INFO - https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:04 INFO - Downloaded 18102510 bytes. 02:33:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:33:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:33:07 INFO - Return code: 0 02:33:07 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:33: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')]} 02:33:07 INFO - https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:33:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:33:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:33:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:33:08 INFO - Downloaded 18102510 bytes. 02:33:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:33:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:33:12 INFO - Return code: 0 02:33: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')]} 02:33:12 INFO - https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:33:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:33:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:33:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:33:13 INFO - Downloaded 10840145 bytes. 02:33:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:33:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:33:13 INFO - Return code: 0 02:33:13 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')]} 02:33:13 INFO - https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:33:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:33:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:33:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 02:33:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 02:33:16 INFO - Downloaded 114248863 bytes. 02:33:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:33:16 INFO - mkdir: /builds/slave/test/properties 02:33:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:33:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:33:16 INFO - Contents: 02:33:16 INFO - build_url:https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:33:17 INFO - Running post-action listener: _resource_record_post_action 02:33:17 INFO - Running post-action listener: set_extra_try_arguments 02:33:17 INFO - ##### 02:33:17 INFO - ##### Running populate-webroot step. 02:33:17 INFO - ##### 02:33:17 INFO - Running pre-action listener: _resource_record_pre_action 02:33:17 INFO - Running main action method: populate_webroot 02:33:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:17 INFO - '--tppagecycles', 02:33:17 INFO - '7'], 02:33:17 INFO - 'tests': ['tsvgm']}}, 02:33:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['damp', 'tps']}, 02:33:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'tests': ['damp', 'tps']}, 02:33:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['dromaeo_dom']}, 02:33:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['a11yr', 02:33:17 INFO - 'ts_paint', 02:33:17 INFO - 'tpaint', 02:33:17 INFO - 'sessionrestore', 02:33:17 INFO - 'sessionrestore_no_auto_restore', 02:33:17 INFO - 'tabpaint']}, 02:33:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:17 INFO - 'ts_paint', 02:33:17 INFO - 'tpaint', 02:33:17 INFO - 'sessionrestore', 02:33:17 INFO - 'sessionrestore_no_auto_restore', 02:33:17 INFO - 'tabpaint']}, 02:33:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:17 INFO - 'ts_paint', 02:33:17 INFO - 'tpaint', 02:33:17 INFO - 'sessionrestore', 02:33:17 INFO - 'sessionrestore_no_auto_restore', 02:33:17 INFO - 'tabpaint']}, 02:33:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:17 INFO - 'ts_paint', 02:33:17 INFO - 'tpaint', 02:33:17 INFO - 'sessionrestore', 02:33:17 INFO - 'sessionrestore_no_auto_restore', 02:33:17 INFO - 'tabpaint']}, 02:33:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['a11yr', 02:33:17 INFO - 'ts_paint', 02:33:17 INFO - 'tpaint', 02:33:17 INFO - 'sessionrestore', 02:33:17 INFO - 'sessionrestore_no_auto_restore', 02:33:17 INFO - 'tabpaint']}, 02:33:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['a11yr', 02:33:17 INFO - 'ts_paint', 02:33:17 INFO - 'tpaint', 02:33:17 INFO - 'sessionrestore', 02:33:17 INFO - 'sessionrestore_no_auto_restore', 02:33:17 INFO - 'tabpaint']}, 02:33:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['tsvgx', 02:33:17 INFO - 'tsvgr_opacity', 02:33:17 INFO - 'tart', 02:33:17 INFO - 'tscrollx', 02:33:17 INFO - 'cart']}, 02:33:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:17 INFO - 'tsvgr_opacity', 02:33:17 INFO - 'tart', 02:33:17 INFO - 'tscrollx', 02:33:17 INFO - 'cart']}, 02:33:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'talos_options': ['--disable-e10s'], 02:33:17 INFO - 'tests': ['tp5o']}, 02:33:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'tests': ['tp5o']}, 02:33:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'talos_options': ['--disable-e10s', 02:33:17 INFO - '--xperf_path', 02:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:17 INFO - 'tests': ['tp5n']}, 02:33:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:17 INFO - 'talos_options': ['--xperf_path', 02:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:17 INFO - 'tests': ['tp5n']}}, 02:33:17 INFO - 'talos.zip': {'path': '', 02:33:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:17 INFO - Running post-action listener: _resource_record_post_action 02:33:17 INFO - ##### 02:33:17 INFO - ##### Running create-virtualenv step. 02:33:17 INFO - ##### 02:33:17 INFO - Running pre-action listener: _resource_record_pre_action 02:33:17 INFO - Running main action method: create_virtualenv 02:33:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:17 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 02:33:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:17 INFO - Using real prefix '/tools/python27' 02:33:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:21 INFO - Installing pip.................done. 02:33:21 INFO - Return code: 0 02:33:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:21 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 02:33:21 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 02:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:21 INFO - 'HOME': '/Users/cltbld', 02:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:21 INFO - 'LOGNAME': 'cltbld', 02:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:21 INFO - 'MOZ_NO_REMOTE': '1', 02:33:21 INFO - 'NO_EM_RESTART': '1', 02:33:21 INFO - 'PAGER': '/bin/cat', 02:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:21 INFO - 'PWD': '/builds/slave/test', 02:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:21 INFO - 'SHELL': '/bin/bash', 02:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:21 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:21 INFO - 'USER': 'cltbld', 02:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:21 INFO - 'XPC_FLAGS': '0x0', 02:33:21 INFO - 'XPC_SERVICE_NAME': '0', 02:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:21 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 02:33:21 INFO - Cleaning up... 02:33:21 INFO - Return code: 0 02:33:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:21 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 02:33:21 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 02:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:21 INFO - 'HOME': '/Users/cltbld', 02:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:21 INFO - 'LOGNAME': 'cltbld', 02:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:21 INFO - 'MOZ_NO_REMOTE': '1', 02:33:21 INFO - 'NO_EM_RESTART': '1', 02:33:21 INFO - 'PAGER': '/bin/cat', 02:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:21 INFO - 'PWD': '/builds/slave/test', 02:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:21 INFO - 'SHELL': '/bin/bash', 02:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:21 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:21 INFO - 'USER': 'cltbld', 02:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:21 INFO - 'XPC_FLAGS': '0x0', 02:33:21 INFO - 'XPC_SERVICE_NAME': '0', 02:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:22 INFO - Downloading/unpacking psutil>=0.7.1 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:24 INFO - Installing collected packages: psutil 02:33:24 INFO - Running setup.py install for psutil 02:33:25 INFO - building 'psutil._psutil_osx' extension 02:33:25 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 02:33:25 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 02:33:25 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 02:33:25 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 02:33:25 INFO - building 'psutil._psutil_posix' extension 02:33:25 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 02:33:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:33:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:33:25 INFO - ^ 02:33:25 INFO - 1 warning generated. 02:33:25 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 02:33:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:26 INFO - Successfully installed psutil 02:33:26 INFO - Cleaning up... 02:33:26 INFO - Return code: 0 02:33:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:33:26 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')]} 02:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:26 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')]} 02:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:26 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:26 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 02:33:26 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 02:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:26 INFO - 'HOME': '/Users/cltbld', 02:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:26 INFO - 'LOGNAME': 'cltbld', 02:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:26 INFO - 'MOZ_NO_REMOTE': '1', 02:33:26 INFO - 'NO_EM_RESTART': '1', 02:33:26 INFO - 'PAGER': '/bin/cat', 02:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:26 INFO - 'PWD': '/builds/slave/test', 02:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:26 INFO - 'SHELL': '/bin/bash', 02:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:26 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:26 INFO - 'USER': 'cltbld', 02:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:26 INFO - 'XPC_FLAGS': '0x0', 02:33:26 INFO - 'XPC_SERVICE_NAME': '0', 02:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:33:26 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 02:33:26 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 02:33:26 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 02:33:26 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 02:33:26 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 02:33:26 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 02:33:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:33:28 INFO - Installing collected packages: mozsystemmonitor 02:33:28 INFO - Running setup.py install for mozsystemmonitor 02:33:29 INFO - Successfully installed mozsystemmonitor 02:33:29 INFO - Cleaning up... 02:33:29 INFO - Return code: 0 02:33:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:29 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:29 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 02:33:29 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 02:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:29 INFO - 'HOME': '/Users/cltbld', 02:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:29 INFO - 'LOGNAME': 'cltbld', 02:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:29 INFO - 'MOZ_NO_REMOTE': '1', 02:33:29 INFO - 'NO_EM_RESTART': '1', 02:33:29 INFO - 'PAGER': '/bin/cat', 02:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:29 INFO - 'PWD': '/builds/slave/test', 02:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:29 INFO - 'SHELL': '/bin/bash', 02:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:29 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:29 INFO - 'USER': 'cltbld', 02:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:29 INFO - 'XPC_FLAGS': '0x0', 02:33:29 INFO - 'XPC_SERVICE_NAME': '0', 02:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 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 02:33:29 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 02:33:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:32 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 02:33:32 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 02:33:32 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 02:33:32 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 02:33:32 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 02:33:32 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 02:33:32 INFO - Downloading docopt-0.6.1.tar.gz 02:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:33 INFO - Running setup.py install for blobuploader 02:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:33 INFO - Running setup.py install for requests 02:33:33 INFO - Running setup.py install for docopt 02:33:33 INFO - Successfully installed blobuploader requests docopt 02:33:33 INFO - Cleaning up... 02:33:33 INFO - Return code: 0 02:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:33 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')]} 02:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:33 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')]} 02:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:33 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:33 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 02:33:33 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 02:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:33 INFO - 'HOME': '/Users/cltbld', 02:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:33 INFO - 'LOGNAME': 'cltbld', 02:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:33 INFO - 'MOZ_NO_REMOTE': '1', 02:33:33 INFO - 'NO_EM_RESTART': '1', 02:33:33 INFO - 'PAGER': '/bin/cat', 02:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:33 INFO - 'PWD': '/builds/slave/test', 02:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:33 INFO - 'SHELL': '/bin/bash', 02:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:33 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:33 INFO - 'USER': 'cltbld', 02:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:33 INFO - 'XPC_FLAGS': '0x0', 02:33:33 INFO - 'XPC_SERVICE_NAME': '0', 02:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-KnPEWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-U5FChE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-meTGGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Ge9tGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-UFT0hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-de04aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0dFQUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-8pZg4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fTXcXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-KBOhdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-2tnq0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-_oOr1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-QIitew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Rea3K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0x0i45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Bntrro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:35 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-jK9tRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:35 INFO - Running setup.py install for manifestparser 02:33:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozcrash 02:33:36 INFO - Running setup.py install for mozdebug 02:33:36 INFO - Running setup.py install for mozdevice 02:33:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozfile 02:33:36 INFO - Running setup.py install for mozhttpd 02:33:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:36 INFO - Running setup.py install for mozinfo 02:33:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozInstall 02:33:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozleak 02:33:37 INFO - Running setup.py install for mozlog 02:33:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for moznetwork 02:33:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozprocess 02:33:37 INFO - Running setup.py install for mozprofile 02:33:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:37 INFO - Running setup.py install for mozrunner 02:33:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:38 INFO - Running setup.py install for mozscreenshot 02:33:38 INFO - Running setup.py install for moztest 02:33:38 INFO - Running setup.py install for mozversion 02:33:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:38 INFO - Cleaning up... 02:33:38 INFO - Return code: 0 02:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:38 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:38 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 02:33:38 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 02:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:38 INFO - 'HOME': '/Users/cltbld', 02:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:38 INFO - 'LOGNAME': 'cltbld', 02:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:38 INFO - 'MOZ_NO_REMOTE': '1', 02:33:38 INFO - 'NO_EM_RESTART': '1', 02:33:38 INFO - 'PAGER': '/bin/cat', 02:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:38 INFO - 'PWD': '/builds/slave/test', 02:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:38 INFO - 'SHELL': '/bin/bash', 02:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:38 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:38 INFO - 'USER': 'cltbld', 02:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:38 INFO - 'XPC_FLAGS': '0x0', 02:33:38 INFO - 'XPC_SERVICE_NAME': '0', 02:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-igijZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:38 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)) 02:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-F_M29i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-62gGwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-7gSzR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ZYEz1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-VuOWBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-RQnuDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-snlWyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-AUXOCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ZVHYNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:39 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)) 02:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-QOPSnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:40 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)) 02:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:40 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-by9DUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:40 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)) 02:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:40 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-JnIuH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:40 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)) 02:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:40 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0nSCE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:40 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)) 02:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:40 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-_HMfpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:40 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)) 02:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:40 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-NynQeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:40 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)) 02:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:40 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fAUP7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:40 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)) 02:33:40 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)) 02:33:40 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)) 02:33:40 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)) 02:33:40 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)) 02:33:40 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)) 02:33:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:40 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 02:33:40 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 02:33:40 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 02:33:40 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 02:33:40 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 02:33:40 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 02:33:43 INFO - Downloading blessings-1.6.tar.gz 02:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:43 INFO - Installing collected packages: blessings 02:33:43 INFO - Running setup.py install for blessings 02:33:43 INFO - Successfully installed blessings 02:33:43 INFO - Cleaning up... 02:33:43 INFO - Return code: 0 02:33:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:43 INFO - Reading from file tmpfile_stdout 02:33:43 INFO - Current package versions: 02:33:43 INFO - blessings == 1.6 02:33:43 INFO - blobuploader == 1.2.4 02:33:43 INFO - docopt == 0.6.1 02:33:43 INFO - manifestparser == 1.1 02:33:43 INFO - mozInstall == 1.12 02:33:43 INFO - mozcrash == 0.17 02:33:43 INFO - mozdebug == 0.1 02:33:43 INFO - mozdevice == 0.48 02:33:43 INFO - mozfile == 1.2 02:33:43 INFO - mozhttpd == 0.7 02:33:43 INFO - mozinfo == 0.9 02:33:43 INFO - mozleak == 0.1 02:33:43 INFO - mozlog == 3.1 02:33:43 INFO - moznetwork == 0.27 02:33:43 INFO - mozprocess == 0.22 02:33:43 INFO - mozprofile == 0.28 02:33:43 INFO - mozrunner == 6.11 02:33:43 INFO - mozscreenshot == 0.1 02:33:43 INFO - mozsystemmonitor == 0.0 02:33:43 INFO - moztest == 0.7 02:33:43 INFO - mozversion == 1.4 02:33:43 INFO - psutil == 3.1.1 02:33:43 INFO - requests == 1.2.3 02:33:43 INFO - wsgiref == 0.1.2 02:33:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:43 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:43 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 02:33:43 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 02:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:43 INFO - 'HOME': '/Users/cltbld', 02:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:43 INFO - 'LOGNAME': 'cltbld', 02:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:43 INFO - 'MOZ_NO_REMOTE': '1', 02:33:43 INFO - 'NO_EM_RESTART': '1', 02:33:43 INFO - 'PAGER': '/bin/cat', 02:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:43 INFO - 'PWD': '/builds/slave/test', 02:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:43 INFO - 'SHELL': '/bin/bash', 02:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:43 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:43 INFO - 'USER': 'cltbld', 02:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:43 INFO - 'XPC_FLAGS': '0x0', 02:33:43 INFO - 'XPC_SERVICE_NAME': '0', 02:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 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)) 02:33:44 INFO - Cleaning up... 02:33:44 INFO - Return code: 0 02:33:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:44 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')]} 02:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:44 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')]} 02:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:44 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:44 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 02:33:44 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 02:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:44 INFO - 'HOME': '/Users/cltbld', 02:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:44 INFO - 'LOGNAME': 'cltbld', 02:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:44 INFO - 'MOZ_NO_REMOTE': '1', 02:33:44 INFO - 'NO_EM_RESTART': '1', 02:33:44 INFO - 'PAGER': '/bin/cat', 02:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:44 INFO - 'PWD': '/builds/slave/test', 02:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:44 INFO - 'SHELL': '/bin/bash', 02:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:44 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:44 INFO - 'USER': 'cltbld', 02:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:44 INFO - 'XPC_FLAGS': '0x0', 02:33:44 INFO - 'XPC_SERVICE_NAME': '0', 02:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:44 INFO - Downloading/unpacking jsonschema 02:33:44 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 02:33:44 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 02:33:44 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 02:33:44 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 02:33:44 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 02:33:44 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 02:33:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:46 INFO - Downloading/unpacking functools32 (from jsonschema) 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:46 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 02:33:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:47 INFO - warning: no files found matching '*.txt' 02:33:47 INFO - no previously-included directories found matching 'build' 02:33:47 INFO - no previously-included directories found matching 'dist' 02:33:47 INFO - no previously-included directories found matching '.git*' 02:33:47 INFO - Installing collected packages: jsonschema, functools32 02:33:47 INFO - Running setup.py install for functools32 02:33:47 INFO - warning: no files found matching '*.txt' 02:33:47 INFO - no previously-included directories found matching 'build' 02:33:47 INFO - no previously-included directories found matching 'dist' 02:33:47 INFO - no previously-included directories found matching '.git*' 02:33:47 INFO - Successfully installed jsonschema functools32 02:33:47 INFO - Cleaning up... 02:33:47 INFO - Return code: 0 02:33:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:33:47 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')]} 02:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:47 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')]} 02:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:47 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 0x103f33a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f43420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafe356bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, '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.WKprgsUmHE/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.BgsEZxOmKU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 02:33:47 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 02:33:47 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 02:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:47 INFO - 'HOME': '/Users/cltbld', 02:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:47 INFO - 'LOGNAME': 'cltbld', 02:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:47 INFO - 'MOZ_NO_REMOTE': '1', 02:33:47 INFO - 'NO_EM_RESTART': '1', 02:33:47 INFO - 'PAGER': '/bin/cat', 02:33:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:47 INFO - 'PWD': '/builds/slave/test', 02:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:47 INFO - 'SHELL': '/bin/bash', 02:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:33:47 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:47 INFO - 'USER': 'cltbld', 02:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:47 INFO - 'XPC_FLAGS': '0x0', 02:33:47 INFO - 'XPC_SERVICE_NAME': '0', 02:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:47 INFO - Downloading/unpacking flake8 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:47 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 02:33:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:33:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:33:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:51 INFO - no previously-included directories found matching 'docs/_build' 02:33:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:33:51 INFO - Running setup.py install for pep8 02:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:51 INFO - no previously-included directories found matching 'docs/_build' 02:33:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:33:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:33:51 INFO - Cleaning up... 02:33:51 INFO - Return code: 0 02:33:51 INFO - Running post-action listener: _resource_record_post_action 02:33:51 INFO - Running post-action listener: _start_resource_monitoring 02:33:51 INFO - Starting resource monitoring. 02:33:51 INFO - ##### 02:33:51 INFO - ##### Running install step. 02:33:51 INFO - ##### 02:33:51 INFO - Running pre-action listener: _resource_record_pre_action 02:33:51 INFO - Running main action method: install 02:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:52 INFO - Reading from file tmpfile_stdout 02:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:52 INFO - Reading from file tmpfile_stdout 02:33:52 INFO - Output received: 02:33:52 INFO - Usage: mozinstall [options] installer 02:33:52 INFO - Options: 02:33:52 INFO - -h, --help show this help message and exit 02:33:52 INFO - -d DEST, --destination=DEST 02:33:52 INFO - Directory to install application into. [default: 02:33:52 INFO - "/builds/slave/test"] 02:33:52 INFO - --app=APP Application being installed. [default: firefox] 02:33:52 INFO - mkdir: /builds/slave/test/build/application 02:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:34:23 INFO - Reading from file tmpfile_stdout 02:34:23 INFO - Output received: 02:34:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:34:23 INFO - Running post-action listener: _resource_record_post_action 02:34:23 INFO - ##### 02:34:23 INFO - ##### Running run-tests step. 02:34:23 INFO - ##### 02:34:23 INFO - Running pre-action listener: _resource_record_pre_action 02:34:23 INFO - Running main action method: run_tests 02:34:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:23 INFO - 2016-05-20 02:34:23.990 screenresolution[1645:7933] starting screenresolution argv=screenresolution get 02:34:23 INFO - 2016-05-20 02:34:23.993 screenresolution[1645:7933] Display 0: 1600x1200x32@60 02:34:24 INFO - 2016-05-20 02:34:23.999 screenresolution[1646:7936] starting screenresolution argv=screenresolution list 02:34:24 INFO - Available Modes on Display 0 02:34:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:24 INFO - Intel Iris: 02:34:24 INFO - Chipset Model: Intel Iris 02:34:24 INFO - Type: GPU 02:34:24 INFO - Bus: Built-In 02:34:24 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:24 INFO - Vendor: Intel (0x8086) 02:34:24 INFO - Device ID: 0x0a2e 02:34:24 INFO - Revision ID: 0x0009 02:34:24 INFO - Displays: 02:34:24 INFO - Display: 02:34:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:24 INFO - Display Serial Number: 1600x1200 60 02:34:24 INFO - Main Display: Yes 02:34:24 INFO - Mirror: Off 02:34:24 INFO - Online: Yes 02:34:24 INFO - Rotation: Supported 02:34:24 INFO - Return code: 0 02:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:24 INFO - Python 2.7.3 02:34:24 INFO - Return code: 0 02:34:24 INFO - grabbing minidump binary from tooltool 02:34:24 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')]} 02:34:24 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 0x103dd2e00>, '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 0x103c3bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dcdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:24 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 02:34:24 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 02:34:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:24 INFO - Return code: 0 02:34:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:34:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:34:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:34:25 INFO - Return code: 0 02:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 02:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --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 02:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WKprgsUmHE/Render', 02:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:25 INFO - 'HOME': '/Users/cltbld', 02:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:25 INFO - 'LOGNAME': 'cltbld', 02:34:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:25 INFO - 'MOZ_NO_REMOTE': '1', 02:34:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:25 INFO - 'NO_EM_RESTART': '1', 02:34:25 INFO - 'PAGER': '/bin/cat', 02:34:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:25 INFO - 'PWD': '/builds/slave/test', 02:34:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:25 INFO - 'SHELL': '/bin/bash', 02:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BgsEZxOmKU/Listeners', 02:34:25 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 02:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:25 INFO - 'USER': 'cltbld', 02:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:25 INFO - 'XPC_FLAGS': '0x0', 02:34:25 INFO - 'XPC_SERVICE_NAME': '0', 02:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 02:34:25 INFO - mozversion application_buildid: 20160520004020 02:34:25 INFO - mozversion application_changeset: 9ba18aae69e626a3f83560df321d91e42316083a 02:34:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:34:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:25 INFO - mozversion application_name: Firefox 02:34:25 INFO - mozversion application_remotingname: firefox-dev 02:34:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:25 INFO - mozversion application_vendor: Mozilla 02:34:25 INFO - mozversion application_version: 48.0a2 02:34:25 INFO - mozversion platform_buildid: 20160520004020 02:34:25 INFO - mozversion platform_changeset: 9ba18aae69e626a3f83560df321d91e42316083a 02:34:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:34:25 INFO - mozversion platform_version: 48.0a2 02:34:25 INFO - using testdate: 1463736865 02:34:25 INFO - actual date: 1463736865 02:34:25 INFO - starting webserver on 'localhost:49279' 02:34:25 INFO - SUITE-START | Running 2 tests 02:34:25 INFO - TEST-START | dromaeo_css 02:34:25 INFO - operating with platform_type : mac_ 02:34:25 INFO - Initialising browser for dromaeo_css test... 02:34:25 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpjQktUj/profile http://localhost:49279/getInfo.html) 02:34:28 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:34:28 INFO - PROCESS | 1664 | colorDepth:24 02:34:28 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:34:28 INFO - PROCESS | 1664 | __metrics 02:34:28 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:34:29 INFO - TEST-INFO | 1664: exit 0 02:34:29 INFO - Browser initialized. 02:34:29 INFO - Running cycle 1/1 for dromaeo_css test... 02:34:29 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpjQktUj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:41 INFO - PROCESS | 1668 | RSS: Main: 220528640 02:34:41 INFO - PROCESS | 1668 | 02:35:31 INFO - PROCESS | 1668 | 1463736931032 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] 02:37:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 02:37:43 INFO - PROCESS | 1668 | RSS: Main: 231510016 02:37:43 INFO - PROCESS | 1668 | 02:40:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 02:40:45 INFO - PROCESS | 1668 | RSS: Main: 243359744 02:40:45 INFO - PROCESS | 1668 | 02:43:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 02:43:48 INFO - PROCESS | 1668 | RSS: Main: 245714944 02:43:48 INFO - PROCESS | 1668 | 02:46:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 02:46:50 INFO - PROCESS | 1668 | RSS: Main: 246747136 02:46:50 INFO - PROCESS | 1668 | 02:49:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 02:49:53 INFO - PROCESS | 1668 | RSS: Main: 250114048 02:49:53 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 02:52:56 INFO - PROCESS | 1668 | RSS: Main: 250478592 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | __start_tp_report 02:52:56 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 02:52:56 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 02:52:56 INFO - PROCESS | 1668 | |i|pagename|runs| 02:52:56 INFO - PROCESS | 1668 | |0;dojo.html;3415.897523074308;3452.0851974226825;3507.0180349502148;3525.594556625987;3564.0377098183476;5481.506664400204;5833.212516310292;5833.3874943130995;5855.443732845373;5858.091995740661;5804.477597016267;5834.037383831674;5834.649921004732;5866.677332746697;5875.76496940123;5229.947700522994;5250.396204436501;5288.867778305535;5303.098473259555;5304.36347638282;5153.510416510426;5257.342832145981;5280.867978300535;5357.223202635635;5373.301470808789;5296.655717378378;5324.520793128618;5329.733513324338;5351.839444816642;5385.838424847261;5282.894342113155;5301.019311427379;5304.734763261821;5325.3875804282225;5359.517643412111;5021.648484606079;5089.567386772129;5146.794128234867;5251.684898906078;5284.5772338212855;4864.708117512925;5544.251526043973;5634.183043458716;5657.603967722261;5658.490735833795;6255.06174073888;6288.779892703734;6303.054541818764;6303.275123360826;6307.905381419282;6183.845403864894;6229.501639868845;6268.247810262752;6326.2724786649205;6330.0821380899515;5956.642601443928;5962.34414214436;5974.103884417285;5977.282726072855;6014.669193194372;6310.747570097236;6330.651814150174;6334.5249106317215;6337.524685648595;6339;6036.0750576275;6197.659128747872;6201.0388389799655;6252.218472690914;6291.245050593958;6294.685265736694;6297.8110656679455;6304.369563043659;6331.2085989251345;6333.36666333363;6129.847850912788;6305;6308.022256550242;6310.274318453345;6313.55805093639;5610;6252.374762523711;6289.0252010938375;6305.3379395163765;6308.8422789429715;3898.3372826618975;4742.1227072991605;4964.429090654621;4987.775550100254;5003.924941125886;4355.455568053993;4376.474823021194;4477.70894891831;4493.438320209973;4517.616002639812;5638.295213098363;5708.229389032427;5883.235179426732;5883.970580147157;5920.644761314335;6273.153124328157;6287;6300.558960872787;6308.7476500940365;6324.08300796382;5690.089585666274;5816.2148110005455;5880.882382352329;5898;5904.114382842522;5470.972645136829;5472;5497.257870187474;5497.670139791625;5531.6957567333375;6419.325970773001;6431.871362572722;6440.291567927524;6463.8060858173385;6471.935280647133;6215.65813880241;6249.406306400884;6306.905396419149;6308.842278943063;6312.905306420499;6408.359164083741;6418.839529011812;6452.709628066842;6462.676866156579;6475.061116138039;6273.090401891609;6315.652639104894;6322.996576626066;6325.778597749057;6334.809955701337;6136.417040381157;6183.690815459119;6238.407351301619;6297.433231009231;6321.399467050623;4829.541193586604;6007.579469437273;6221.502279817513;6252.5935814171935;6259.780907668392;6211.16149319836;6248.343923887926;6256.593321434092;6257;6289.842753931189;5891.882162356643;6023.608465449732;6027.336992930686;6084.756609735561;6112.083187521907;6195.201657898975;6235.3452887446165;6249.937500624936;6269.592476489013;6276.717547710273;5300.920486192633;5862.091375836752;6174.938250617616;6188.009918413032;6192 02:52:56 INFO - PROCESS | 1668 | |1;ext.html;486.4065839675597;544.9564084777651;548.7228949380562;553.3802141601407;645.1612903225805;27163.18510444685;30219.395612087774;37511.812440937756;37801.62198378012;37866.62133378666;32858.342833143324;34354.828225858895;38882.8055859721;40150.59849401505;40811.183776324455;9420.481873496972;9647.75880602987;9650.5174741263;9659.661911833087;9704.175145112638;9548.092931171528;9753.90246097537;9759.609615615367;9778.559964801565;9810.607575696964;9750.36622619531;9820.459874706889;9832.852507212398;9841.26190535709;9870.802583948316;9709.41743495389;9779.364341317792;9801.754956126082;9826.1156495915;9869.950650246774;9555.518894571353;9657.275704322205;9658.517074146264;9658.75853103671;9659.806803863954;39107.60892391068;39318;39440.80279598612;39494.60505394938;39539.8023009886;2738.3701748597737;3122.35991621717;3221.4201443740117;3254.2189874429964;3260.9347813043605;29365.853170734008;30109.548356774667;30459.847700761355;30632;31040.22399440032;2753.105240796749;2779.0551212587616;2801.635787347632;2867.4121805029918;2914.2714321419644;391650;392713.036434816;393465;397396.0130199359;398886;38148.61851381506;66563;67571.66214168898;67602.66198668975;71090;37797.81101094532;37843.81078094592;38174.23651526954;38206;38235;15394.615134621725;15702.528924132293;15759.842401576067;15764.448244311623;15799;13049.869501305055;13164.210147391188;13164.539241126515;13169.144005639795;13194.802077968838;8396.160383961676;8421.399934012641;8480.279176270085;8591.6992905248;8646.13538646143;3496.30073985204;3577.499150118985;3579.427291633326;3617.0957260684827;3627.2745450909397;976.2287792643732;1023.9385636861663;1070.1920050361928;1102.2229328323674;1149.83327417524;29981.550276745867;30342.84828575843;30348.544771827997;30433.934812281906;30621.387572248877;876.9429987050821;1002.3935519011039;1084.6312253833735;1129.8249820187077;1213.7511810078913;15004.949653524367;15325.540233793005;15339.769903451457;15703.371865125268;15708.293126809322;634912;637404;644152;645047;646778;60286;60381;60854;60918.39081609127;60950;1321.3921596065725;1441.9495317663832;1453.324204245031;1476.2323591732454;1483.5994281544138;29395.265118372212;29663.851680742322;29729.108126756233;30122.548161778028;30434.695653044073;44472.88817779452;47832.282515762985;51314;51500.48499514957;51663;520909;528718;538075;539003;540118;27372.726272737018;27631.861840690668;28036.43927121487;28092;28107.859460702566;45583;45662.543374567154;45783;47241.52758472371;47508.049839002335;36950.89147325585;37754.43368349422;37951;38074.619253807105;38598;37644;37913.62086379101;38321.80839095786;38390.2321953565;38809.417858732704;28576.57135143016;36664;37499.81250093732;37819.81090094532;37975.81012095032;30585.54121688132;31116.844415777778;31658.050258492283;31692.841535793097;31744.6825531751;20930.95345232702;21793.455163621038;24006.27981160568;24222.51554968926;24668.1366152191 02:52:56 INFO - PROCESS | 1668 | |2;jquery.html;402.32409551952725;403.6528585416541;403.8344278845674;409.3000968344131;412.8947118484786;16650.33398664052;20421.795782042176;20848.791512084874;20890;21125.47186320341;20574.588508229826;20864.791352086475;21378.46553836155;21935.561288774254;22021.119155233773;5768.451997060272;5832.912506312408;5986.28164620244;6018.15745795589;6031.668258245794;4924.507549245082;4982.402111746595;5613.242212301348;5960.463558279754;6006.369331220225;5875;5911.763529458816;5913.586048976574;5922.407759224065;5922.555808314372;6001.399860014008;6578.177727784027;6589.769358072468;6635.767748128841;6655.600663960154;5035.370578677665;5730;5830.5044071254;5880.353161152269;5917.674527900964;24426.877865610735;24720.07707552308;24974.125905593217;25007.62488562673;25765.711714414203;2192.0241052810193;2237.5077482953725;2303.8156947444163;2315.131825565413;2429.9878500607383;9775.387061134905;10025.749356266078;10094.192464602815;10355.79288414235;10393.064624183784;1657.3536320834885;1811.529002459357;1828.2321425001398;1852.6109517001446;1859.5537071102838;81325.59337203336;110911;113089.43455282753;115667;117395;11735.471903764352;11929.926306632446;11956.461959211856;11962.162648614514;12078.033757299396;13463.596092117252;14396.28018599066;15005.099694018394;15055.247237638294;15154.545363638888;7391.593462359514;8646.6973655923;8926.642934282556;9092.954535227414;9140.497272650067;8503.57648070297;9045.185933266037;9047.728568142966;9062.81874362509;9100.726978190665;3764.642358975893;4714.811407543729;4723.173444647173;4723.338732577442;4766.713997160182;1882.2471011595471;1932.806719328056;1952.1508143957424;1956.5891162855676;1957.3442896629788;915.1763412928418;979.060102301784;985.4875464758286;1001.6594357918343;1017.6641708236413;20661.793382066287;20912.581748364948;20938;21014.684779728315;21248.575028499345;980.3186785184371;1003.0972125087334;1012.9139023182964;1017.1506791828906;1017.5014243021014;10986.505607247533;10989.06592939609;10997.450127493594;11024.779504409868;11083.057940075183;607826;617589;625127;638735;638948;123340.76659233472;127388.36305818598;128281.35859320831;129207.41585168432;131047;1018.9286749927434;1021.269792098653;1035.342557475993;1036.0520124086377;1044.2248178097266;18200.998945057618;18620.44138675842;18631.788933719265;18772.3429679966;18968.0515974198;38897.88331234652;49735.50264497309;50458;51651.93066586683;55022.72488637531;75922.24077759152;77225.61387193252;77973;79636.00909977297;80768.3846323082;8164.510129392255;8210.876836847572;8241.629126689433;8316.916830831615;8567.443116197428;11933.701657458632;12284.938575307066;12343.69140771488;12523;12527.93736031314;4832.154372984784;5302.39022512416;7849.686012559434;9679.08048735369;10986.615468458565;8955.910440895508;10455.843162352723;10603.151747859998;10854.131669466582;10962.945185274022;6908.861822763416;8253.711120111007;11015.614453494089;11029.895694142442;11147.609833655782;8040.115587285511;8173.550454724809;8205.753827385188;8255.215754503313;8486.787830304045;8307.792305192419;10975.670729878117;11120.277181983145;11156.330620162817;11181 02:52:56 INFO - PROCESS | 1668 | |3;mootools.html;1612.6129728865071;1633.8284480129587;1885.7925628180897;1941.941741747748;2024.7064175694534;7349.669264883079;7707.845843083135;8454.112318206591;8859.557022148883;8885.955570222148;6754.560953538016;8585.356098292637;8673.132686731324;8682;8703.477791332525;2439.499902519979;2442.096424322994;2448.681671382718;2451.5587194305017;2465.408302007514;2424.3029380195167;2491.813114016447;2492.2149522900318;2502.4995000999784;2512.346789834638;2466.099873546161;2474.381404648838;2481.8759062046825;2498.1880888711153;2502.4744803591266;2433.914812981546;2462.91379801707;2475.6039033754605;2484.465839844442;2489.2781093482868;2075.9065842037144;2141.807237348646;2254.531288239392;2286.8284878634004;2456.103522214397;8673.262772664331;8771.12288771124;8798.032216456184;8807.295416366675;8819.647214111428;5300.867478313035;5370.5435038021815;5460.153676180159;5484.8354549363585;5505.724713764296;3514.1039035046156;3559.6440355964455;3608.981955090234;3622.601513833476;3646.5988741238443;999.6601155607055;1066.8346406307035;1066.8506409102731;1069.5187165775355;1072.9034386905216;11666.650000499998;11816.468258928282;11843.822342664867;11850.585229516926;11862.822057669142;4755.2153894607;4805.9443511776535;4861.80552777892;4877.487863774323;4887.291342755351;10136.493175341204;10139.949300253451;10141.847872281922;10148.188144948534;10157.035081667229;5453.536449401766;5465.535429488458;5474.151506516497;5491.066518691832;5502.614816962854;4389.758563278986;4798.760061996886;4887;4915.803367865316;4974.975125124423;3988.4216788566077;4046.979765101156;4077.3894311746694;4092.1406504633765;4144.046869220036;1342.731453709262;1348.7235116801032;1351.8715722006393;1355.8101865738804;1369.8767110959861;723.0491903147449;806.891069705594;861.4099341950783;871.3769654696796;947.0245646983618;5679.630823996427;5745.425457454221;5774.451427114417;5846.152307915413;6001.909971350433;929.9581518831669;955.8709574207533;968.1286841842258;1002.5839276700087;1033.9224558158169;3406.744494162948;3854.4603755474254;3884.3396622574232;3944.8619298324993;4028.697847661437;9879.851802222973;9900.900990989998;10555.155587552978;10900.50947707355;10906.182036347305;9907.603695852229;10722.892771072346;10730.087942524817;10787.892121078845;10829.729256768644;7438.218987006287;8265.793355166168;8323.458975166595;8342.874856877152;8343.54110523927;5521.337439507285;5647.548196144381;5720.8283751487525;5780.826575202751;5926.733297001559;7824.843503129791;8069.233422824822;8078.6364613593705;9528.666496672584;9657.661981830603;9807.215422766305;9899.505024748878;9929.404235745878;9937.900620993698;10098.394096354243;7013.544119632207;7079.327463890922;7508.549487030796;7508.774736757906;7577.469577129768;8255.752327430188;8275.875861862198;8341.95829020851;8345.791355215926;8372.497650141011;7229.530080544748;7390.29792169743;7403.66683499233;7455.589942552995;7477;7190.532615379983;7369;7380.483366164317;7450.739224127129;7487.812804679927;7006.544574602634;7025.192102908231;7060.964695176492;7062.364387205176;7092.893606595802;4760.262159365304;4842.201036828884;4888.706677599355;4906.969536397397;4937.679050861682;4126.525449573217;4893.657443978887;4908.950910490849;4971.552560269593;5175.171972484384 02:52:56 INFO - PROCESS | 1668 | |4;prototype.html;247.65452194189106;302.825875121805;326.2659017211276;329.515612050286;331.5143315043461;6019;6579.276279609245;6596.835079123024;6692.698828552715;6716.79849604512;6041.154238406627;6586.374294442032;6614.040964060208;6620.668966551665;6649.368310010541;3940.330143875548;4114.382842573608;4272.359146128075;4699.506551812054;4758.0721759256785;3933.8819835404843;4043.353063509839;4808.639352048593;4880.463149053619;4923.852284431473;4818.927716084261;4906.877328066791;4932.630052746058;4933.481984391641;4933.876653083666;4924.089043526941;4941.802327906879;4951.752412379403;4965.627577931669;4974.776135073894;3484.9651503485147;4187;4196.853110141131;4204.411382406465;4228.619424251801;6165.013597824372;6387.105805187278;6399.848027355074;6426.421622053991;6438.227412710505;5846.795362162304;5890.617109887844;5894.17481552583;5895.587308888379;5925.970370148165;7126.964365178193;7146.3568278855155;7168.247334029904;7169.605671688055;7219.639018049076;4726.550977657117;4728;4733.171694953369;4757.833475828329;4775.307580400822;5991.310999235056;7569.7350592729545;7603.695852165907;7618.809529761745;7630.809229769245;4520.50274469808;4693.272542755878;4693.577578017995;4702.059588082398;4839.637027222972;4771.570558649738;4784.808607655725;4789.592884604847;4804.399450068741;4810.95189048112;5700.401457846866;5718.79984200551;5733.541316694655;5737.110747834093;5767.509761670221;7236;7256.6734496947765;7268.927310726931;7272.272772722686;7286.635668216568;1632.616335161236;1655.1558705060506;1659.7427398753211;1661.6012157082214;1667.5497615643708;863.4905405810601;1012.7012531303283;1050.6847945616285;1052.1530168214508;1059.8357254625546;6554.868902621921;6589.374009469093;6635.601863888182;6636.867262654817;6678.764428580631;7445.915143759756;7449.366803821627;7461.365783908429;7489.925100749032;7497.2877576630135;5508.834734957958;6454.903176452357;6573.441257493071;6735.158105236846;6758;3908.394198899175;3969.206158768258;3971.324874771296;3973.5827738087087;3977.5028121484816;6721.361470660279;7450.366718828852;7822.765317040498;7873.09459412175;7897.565633890076;7538.434617403716;7817.140114587391;7824.921750782533;7830.4518683691595;7838.255365740246;7831.295183433518;7876.606169691492;7881.133075361706;7933.761987140395;7967.601619918981;6007;6272.905906411316;7458.627068646438;7488.3525624362555;7489.176190618919;7369.042024536776;7422.146453157956;7427.480076394817;7434.182239953492;7435.888461672971;7566.281203285679;7875.921240787748;7892.658248097722;7895.84208315842;7901.486403383762;4661.300804879295;4694.06118776253;4694.694844835075;4707.340972263954;4720.693154944917;7523.473356864967;7532.246775322424;7535.623218839146;7536.663634273393;7538.3215510604305;7204.747833825791;7231.3130252625915;7236.89144662841;7242.855142897218;7254.202037775735;6915.273896240822;7158.534695244793;7209.963950180216;7215.134183897966;7228.530145540523;7021.613811240431;7027.894581581382;7049.08361912948;7058.61177635235;7060.364567188978;5825.70871456417;7249.637518123967;7255.129384473897;7302.306280903305;7305.817354566178;7107.466939979626;7135.82160445993;7138.750143744944;7140.642967851691;7140.678669459783 02:52:56 INFO - PROCESS | 1668 | |5;yui.html;625.5558553427066;656.9080328753978;657.4313219065507;722.8518153778474;742.2392048150645;14767.409303627855;14883.92558037211;14964.401423943029;15032.549023529284;15047.172405517706;13341.93329033356;13638.045336826426;13668.521601743942;13681.65795855104;13689.58931232062;724.6775185042658;891.6923661336829;895.8342706599284;913.5432283858071;935.9719208423758;782.1982467970319;916.7295647783886;924.9491277979708;925.0795458518784;925.5511077127621;833.4124442268217;958.324381311174;977.9608815647401;989.8564708117318;997.316837965992;949.539473355422;976.1019861727228;979.8040391921609;982.8230918434679;985.7929834734714;702.7891632510226;710.0378986473306;714.9320814522612;721.72935149319;722.9927700722978;15189.240537973168;15235.162066086361;15304.311305991258;15305.38778448872;15360.539183824503;12864.29246391448;12994.090413671047;13078.41147148371;13096.541621043218;13100.737985240337;9858.9507052465;9900.752481187956;10072.294939354248;10127.797444051077;10137.797244055151;3464.9826750866087;3511.613722490524;3514.5431093957877;3584.6415358463946;3670.0274427276795;64503;69256;77425;78565.60717196492;83942.58028709817;8222.62998165084;9103.68137115211;9237.168654821098;9403.811923761486;9414.435133891988;20490.692639610417;20594.588108237753;20634.690479642817;20689.17243310281;20700.068496917676;7308;7397.519161254501;7437.628118594049;7471.476996610294;7493.775186744298;3417.6069751978343;3926.960730392717;4007.338789099766;4056.533498647634;4122.0107174277955;3224.822634755064;3280.901572952815;3293.2919422324317;3299.785513941586;3305.5702758641223;658.499540349338;660.8678264347054;669.5480550628404;681.2029924987776;686.7356067913889;467.37138548652007;537.5565158743974;586.2993722501654;589.8790747896671;600.0339453479894;8020.318272946748;8078.35373170145;8198.344132469389;8198.877016844752;8240.711575094963;536.0886492961903;591.6243185577104;594.3521561497988;599.9500873471425;604.9793689078499;3586.1931065510053;3823.598522155189;3825.464434979105;3998.8000599969887;4040.939385909214;90375;93828;94715.52642236745;95205.047949521;97226;79536;79916;80362;80559;80660.19339806645;51839.74080129575;72537.6373118131;72568.99999999894;72851.63574182095;74203.5159296811;7747.496412733154;7789.376849852111;7950.24472675095;8174.918250817654;8236.382271329554;36697.63302366942;48454.757726211144;49334.27330043431;50455;51169.488305117964;53830;58495.83008339724;60512;66889.32776680622;67252.32747672657;10846.403447810446;10940.507677154388;10955.397453140155;10981.121510279318;11394.54421823151;11285.830712539155;11736.88263117358;11845.881541184477;12095.637130886087;12458.937705311415;10995.945020274847;11183.161262905152;11232.606858759904;11375.54497820078;11519.02088322502;11444.828327574927;11479.483423246142;11543.942280288546;11789.351585662871;11966.760664786481;10951.616693415692;11038.834417483584;11231.831522527005;11266.7746645065;11441.656750297505;9630.951845240728;9733.270004749531;9749.268804839523;10018.799624007333;10028.548715307683;9481;9592.184664303611;9665.758356041155;9675.03249675027;9705.854412183682 02:52:56 INFO - PROCESS | 1668 | __end_tp_report 02:52:56 INFO - PROCESS | 1668 | __start_cc_report 02:52:56 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,420 02:52:56 INFO - PROCESS | 1668 | __end_cc_report 02:52:56 INFO - PROCESS | 1668 | __startTimestamp1463737976291__endTimestamp 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | ------- Summary: start ------- 02:52:56 INFO - PROCESS | 1668 | Number of tests: 6 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5801.65 Median:6027.34 stddev:667.05 (11.1%) stddev-sans-first:642.30 02:52:56 INFO - PROCESS | 1668 | Values: 3415.9 3452.1 3507.0 3525.6 3564.0 5481.5 5833.2 5833.4 5855.4 5858.1 5804.5 5834.0 5834.6 5866.7 5875.8 5229.9 5250.4 5288.9 5303.1 5304.4 5153.5 5257.3 5280.9 5357.2 5373.3 5296.7 5324.5 5329.7 5351.8 5385.8 5282.9 5301.0 5304.7 5325.4 5359.5 5021.6 5089.6 5146.8 5251.7 5284.6 4864.7 5544.3 5634.2 5657.6 5658.5 6255.1 6288.8 6303.1 6303.3 6307.9 6183.8 6229.5 6268.2 6326.3 6330.1 5956.6 5962.3 5974.1 5977.3 6014.7 6310.7 6330.7 6334.5 6337.5 6339.0 6036.1 6197.7 6201.0 6252.2 6291.2 6294.7 6297.8 6304.4 6331.2 6333.4 6129.8 6305.0 6308.0 6310.3 6313.6 5610.0 6252.4 6289.0 6305.3 6308.8 3898.3 4742.1 4964.4 4987.8 5003.9 4355.5 4376.5 4477.7 4493.4 4517.6 5638.3 5708.2 5883.2 5884.0 5920.6 6273.2 6287.0 6300.6 6308.7 6324.1 5690.1 5816.2 5880.9 5898.0 5904.1 5471.0 5472.0 5497.3 5497.7 5531.7 6419.3 6431.9 6440.3 6463.8 6471.9 6215.7 6249.4 6306.9 6308.8 6312.9 6408.4 6418.8 6452.7 6462.7 6475.1 6273.1 6315.7 6323.0 6325.8 6334.8 6136.4 6183.7 6238.4 6297.4 6321.4 4829.5 6007.6 6221.5 6252.6 6259.8 6211.2 6248.3 6256.6 6257.0 6289.8 5891.9 6023.6 6027.3 6084.8 6112.1 6195.2 6235.3 6249.9 6269.6 6276.7 5300.9 5862.1 6174.9 6188.0 6192.0 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:64917.87 Median:37963.41 stddev:142678.75 (375.8%) stddev-sans-first:142996.99 02:52:56 INFO - PROCESS | 1668 | Values: 486.4 545.0 548.7 553.4 645.2 27163.2 30219.4 37511.8 37801.6 37866.6 32858.3 34354.8 38882.8 40150.6 40811.2 9420.5 9647.8 9650.5 9659.7 9704.2 9548.1 9753.9 9759.6 9778.6 9810.6 9750.4 9820.5 9832.9 9841.3 9870.8 9709.4 9779.4 9801.8 9826.1 9870.0 9555.5 9657.3 9658.5 9658.8 9659.8 39107.6 39318.0 39440.8 39494.6 39539.8 2738.4 3122.4 3221.4 3254.2 3260.9 29365.9 30109.5 30459.8 30632.0 31040.2 2753.1 2779.1 2801.6 2867.4 2914.3 391650.0 392713.0 393465.0 397396.0 398886.0 38148.6 66563.0 67571.7 67602.7 71090.0 37797.8 37843.8 38174.2 38206.0 38235.0 15394.6 15702.5 15759.8 15764.4 15799.0 13049.9 13164.2 13164.5 13169.1 13194.8 8396.2 8421.4 8480.3 8591.7 8646.1 3496.3 3577.5 3579.4 3617.1 3627.3 976.2 1023.9 1070.2 1102.2 1149.8 29981.6 30342.8 30348.5 30433.9 30621.4 876.9 1002.4 1084.6 1129.8 1213.8 15004.9 15325.5 15339.8 15703.4 15708.3 634912.0 637404.0 644152.0 645047.0 646778.0 60286.0 60381.0 60854.0 60918.4 60950.0 1321.4 1441.9 1453.3 1476.2 1483.6 29395.3 29663.9 29729.1 30122.5 30434.7 44472.9 47832.3 51314.0 51500.5 51663.0 520909.0 528718.0 538075.0 539003.0 540118.0 27372.7 27631.9 28036.4 28092.0 28107.9 45583.0 45662.5 45783.0 47241.5 47508.0 36950.9 37754.4 37951.0 38074.6 38598.0 37644.0 37913.6 38321.8 38390.2 38809.4 28576.6 36664.0 37499.8 37819.8 37975.8 30585.5 31116.8 31658.1 31692.8 31744.7 20931.0 21793.5 24006.3 24222.5 24668.1 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:35291.79 Median:13428.43 stddev:104016.18 (774.6%) stddev-sans-first:104274.98 02:52:56 INFO - PROCESS | 1668 | Values: 402.3 403.7 403.8 409.3 412.9 16650.3 20421.8 20848.8 20890.0 21125.5 20574.6 20864.8 21378.5 21935.6 22021.1 5768.5 5832.9 5986.3 6018.2 6031.7 4924.5 4982.4 5613.2 5960.5 6006.4 5875.0 5911.8 5913.6 5922.4 5922.6 6001.4 6578.2 6589.8 6635.8 6655.6 5035.4 5730.0 5830.5 5880.4 5917.7 24426.9 24720.1 24974.1 25007.6 25765.7 2192.0 2237.5 2303.8 2315.1 2430.0 9775.4 10025.7 10094.2 10355.8 10393.1 1657.4 1811.5 1828.2 1852.6 1859.6 81325.6 110911.0 113089.4 115667.0 117395.0 11735.5 11929.9 11956.5 11962.2 12078.0 13463.6 14396.3 15005.1 15055.2 15154.5 7391.6 8646.7 8926.6 9093.0 9140.5 8503.6 9045.2 9047.7 9062.8 9100.7 3764.6 4714.8 4723.2 4723.3 4766.7 1882.2 1932.8 1952.2 1956.6 1957.3 915.2 979.1 985.5 1001.7 1017.7 20661.8 20912.6 20938.0 21014.7 21248.6 980.3 1003.1 1012.9 1017.2 1017.5 10986.5 10989.1 10997.5 11024.8 11083.1 607826.0 617589.0 625127.0 638735.0 638948.0 123340.8 127388.4 128281.4 129207.4 131047.0 1018.9 1021.3 1035.3 1036.1 1044.2 18201.0 18620.4 18631.8 18772.3 18968.1 38897.9 49735.5 50458.0 51651.9 55022.7 75922.2 77225.6 77973.0 79636.0 80768.4 8164.5 8210.9 8241.6 8316.9 8567.4 11933.7 12284.9 12343.7 12523.0 12527.9 4832.2 5302.4 7849.7 9679.1 10986.6 8955.9 10455.8 10603.2 10854.1 10962.9 6908.9 8253.7 11015.6 11029.9 11147.6 8040.1 8173.6 8205.8 8255.2 8486.8 8307.8 10975.7 11120.3 11156.3 11181.0 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5663.09 Median:4954.62 stddev:3112.41 (62.8%) stddev-sans-first:3106.25 02:52:56 INFO - PROCESS | 1668 | Values: 1612.6 1633.8 1885.8 1941.9 2024.7 7349.7 7707.8 8454.1 8859.6 8886.0 6754.6 8585.4 8673.1 8682.0 8703.5 2439.5 2442.1 2448.7 2451.6 2465.4 2424.3 2491.8 2492.2 2502.5 2512.3 2466.1 2474.4 2481.9 2498.2 2502.5 2433.9 2462.9 2475.6 2484.5 2489.3 2075.9 2141.8 2254.5 2286.8 2456.1 8673.3 8771.1 8798.0 8807.3 8819.6 5300.9 5370.5 5460.2 5484.8 5505.7 3514.1 3559.6 3609.0 3622.6 3646.6 999.7 1066.8 1066.9 1069.5 1072.9 11666.7 11816.5 11843.8 11850.6 11862.8 4755.2 4805.9 4861.8 4877.5 4887.3 10136.5 10139.9 10141.8 10148.2 10157.0 5453.5 5465.5 5474.2 5491.1 5502.6 4389.8 4798.8 4887.0 4915.8 4975.0 3988.4 4047.0 4077.4 4092.1 4144.0 1342.7 1348.7 1351.9 1355.8 1369.9 723.0 806.9 861.4 871.4 947.0 5679.6 5745.4 5774.5 5846.2 6001.9 930.0 955.9 968.1 1002.6 1033.9 3406.7 3854.5 3884.3 3944.9 4028.7 9879.9 9900.9 10555.2 10900.5 10906.2 9907.6 10722.9 10730.1 10787.9 10829.7 7438.2 8265.8 8323.5 8342.9 8343.5 5521.3 5647.5 5720.8 5780.8 5926.7 7824.8 8069.2 8078.6 9528.7 9657.7 9807.2 9899.5 9929.4 9937.9 10098.4 7013.5 7079.3 7508.5 7508.8 7577.5 8255.8 8275.9 8342.0 8345.8 8372.5 7229.5 7390.3 7403.7 7455.6 7477.0 7190.5 7369.0 7380.5 7450.7 7487.8 7006.5 7025.2 7061.0 7062.4 7092.9 4760.3 4842.2 4888.7 4907.0 4937.7 4126.5 4893.7 4909.0 4971.6 5175.2 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5842.93 Median:6587.87 stddev:1913.16 (29.0%) stddev-sans-first:1871.86 02:52:56 INFO - PROCESS | 1668 | Values: 247.7 302.8 326.3 329.5 331.5 6019.0 6579.3 6596.8 6692.7 6716.8 6041.2 6586.4 6614.0 6620.7 6649.4 3940.3 4114.4 4272.4 4699.5 4758.1 3933.9 4043.4 4808.6 4880.5 4923.9 4818.9 4906.9 4932.6 4933.5 4933.9 4924.1 4941.8 4951.8 4965.6 4974.8 3485.0 4187.0 4196.9 4204.4 4228.6 6165.0 6387.1 6399.8 6426.4 6438.2 5846.8 5890.6 5894.2 5895.6 5926.0 7127.0 7146.4 7168.2 7169.6 7219.6 4726.6 4728.0 4733.2 4757.8 4775.3 5991.3 7569.7 7603.7 7618.8 7630.8 4520.5 4693.3 4693.6 4702.1 4839.6 4771.6 4784.8 4789.6 4804.4 4811.0 5700.4 5718.8 5733.5 5737.1 5767.5 7236.0 7256.7 7268.9 7272.3 7286.6 1632.6 1655.2 1659.7 1661.6 1667.5 863.5 1012.7 1050.7 1052.2 1059.8 6554.9 6589.4 6635.6 6636.9 6678.8 7445.9 7449.4 7461.4 7489.9 7497.3 5508.8 6454.9 6573.4 6735.2 6758.0 3908.4 3969.2 3971.3 3973.6 3977.5 6721.4 7450.4 7822.8 7873.1 7897.6 7538.4 7817.1 7824.9 7830.5 7838.3 7831.3 7876.6 7881.1 7933.8 7967.6 6007.0 6272.9 7458.6 7488.4 7489.2 7369.0 7422.1 7427.5 7434.2 7435.9 7566.3 7875.9 7892.7 7895.8 7901.5 4661.3 4694.1 4694.7 4707.3 4720.7 7523.5 7532.2 7535.6 7536.7 7538.3 7204.7 7231.3 7236.9 7242.9 7254.2 6915.3 7158.5 7210.0 7215.1 7228.5 7021.6 7027.9 7049.1 7058.6 7060.4 5825.7 7249.6 7255.1 7302.3 7305.8 7107.5 7135.8 7138.8 7140.6 7140.7 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17908.29 Median:599.99 stddev:25223.91 (4204.0%) stddev-sans-first:25261.28 02:52:56 INFO - PROCESS | 1668 | Values: 625.6 656.9 657.4 722.9 742.2 14767.4 14883.9 14964.4 15032.5 15047.2 13341.9 13638.0 13668.5 13681.7 13689.6 724.7 891.7 895.8 913.5 936.0 782.2 916.7 924.9 925.1 925.6 833.4 958.3 978.0 989.9 997.3 949.5 976.1 979.8 982.8 985.8 702.8 710.0 714.9 721.7 723.0 15189.2 15235.2 15304.3 15305.4 15360.5 12864.3 12994.1 13078.4 13096.5 13100.7 9859.0 9900.8 10072.3 10127.8 10137.8 3465.0 3511.6 3514.5 3584.6 3670.0 64503.0 69256.0 77425.0 78565.6 83942.6 8222.6 9103.7 9237.2 9403.8 9414.4 20490.7 20594.6 20634.7 20689.2 20700.1 7308.0 7397.5 7437.6 7471.5 7493.8 3417.6 3927.0 4007.3 4056.5 4122.0 3224.8 3280.9 3293.3 3299.8 3305.6 658.5 660.9 669.5 681.2 686.7 467.4 537.6 586.3 589.9 600.0 8020.3 8078.4 8198.3 8198.9 8240.7 536.1 591.6 594.4 600.0 605.0 3586.2 3823.6 3825.5 3998.8 4040.9 90375.0 93828.0 94715.5 95205.0 97226.0 79536.0 79916.0 80362.0 80559.0 80660.2 51839.7 72537.6 72569.0 72851.6 74203.5 7747.5 7789.4 7950.2 8174.9 8236.4 36697.6 48454.8 49334.3 50455.0 51169.5 53830.0 58495.8 60512.0 66889.3 67252.3 10846.4 10940.5 10955.4 10981.1 11394.5 11285.8 11736.9 11845.9 12095.6 12458.9 10995.9 11183.2 11232.6 11375.5 11519.0 11444.8 11479.5 11543.9 11789.4 11966.8 10951.6 11038.8 11231.8 11266.8 11441.7 9631.0 9733.3 9749.3 10018.8 10028.5 9481.0 9592.2 9665.8 9675.0 9705.9 02:52:56 INFO - PROCESS | 1668 | -------- Summary: end -------- 02:52:56 INFO - PROCESS | 1668 | 02:52:56 INFO - TEST-INFO | 1668: exit 0 02:52:56 INFO - TEST-OK | dromaeo_css | took 1111191ms 02:52:56 INFO - TEST-START | kraken 02:52:56 INFO - operating with platform_type : mac_ 02:52:56 INFO - Initialising browser for kraken test... 02:52:56 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpoHkK0o/profile http://localhost:49279/getInfo.html) 02:52:59 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 02:52:59 INFO - PROCESS | 1679 | colorDepth:24 02:52:59 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 02:52:59 INFO - PROCESS | 1679 | __metrics 02:52:59 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 02:53:00 INFO - TEST-INFO | 1679: exit 0 02:53:00 INFO - Browser initialized. 02:53:00 INFO - Running cycle 1/1 for kraken test... 02:53:00 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpoHkK0o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:12 INFO - PROCESS | 1683 | RSS: Main: 221450240 02:53:12 INFO - PROCESS | 1683 | 02:53:15 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 02:53:15 INFO - PROCESS | 1683 | RSS: Main: 232955904 02:53:15 INFO - PROCESS | 1683 | 02:53:18 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 02:53:19 INFO - PROCESS | 1683 | RSS: Main: 241917952 02:53:19 INFO - PROCESS | 1683 | 02:53:22 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 02:53:23 INFO - PROCESS | 1683 | RSS: Main: 245542912 02:53:23 INFO - PROCESS | 1683 | 02:53:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 02:53:26 INFO - PROCESS | 1683 | RSS: Main: 247054336 02:53:26 INFO - PROCESS | 1683 | 02:53:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:53:28 INFO - PROCESS | 1683 | RSS: Main: 247296000 02:53:28 INFO - PROCESS | 1683 | 02:53:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 02:53:32 INFO - PROCESS | 1683 | RSS: Main: 247607296 02:53:32 INFO - PROCESS | 1683 | 02:53:35 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:36 INFO - PROCESS | 1683 | RSS: Main: 247844864 02:53:36 INFO - PROCESS | 1683 | 02:53:38 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 02:53:39 INFO - PROCESS | 1683 | RSS: Main: 247988224 02:53:39 INFO - PROCESS | 1683 | 02:53:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:41 INFO - PROCESS | 1683 | RSS: Main: 247599104 02:53:41 INFO - PROCESS | 1683 | 02:53:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:44 INFO - PROCESS | 1683 | RSS: Main: 247582720 02:53:44 INFO - PROCESS | 1683 | 02:53:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:47 INFO - PROCESS | 1683 | RSS: Main: 247930880 02:53:47 INFO - PROCESS | 1683 | 02:53:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:50 INFO - PROCESS | 1683 | RSS: Main: 247988224 02:53:50 INFO - PROCESS | 1683 | 02:53:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:54 INFO - PROCESS | 1683 | RSS: Main: 248004608 02:53:54 INFO - PROCESS | 1683 | 02:53:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 02:53:56 INFO - PROCESS | 1683 | RSS: Main: 249851904 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | __start_tp_report 02:53:56 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 02:53:56 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 02:53:56 INFO - PROCESS | 1683 | |i|pagename|runs| 02:53:56 INFO - PROCESS | 1683 | |0;ai-astar;121;105;162;175;169;115;110;116;116;117 02:53:56 INFO - PROCESS | 1683 | |1;audio-beat-detection;150;123;155;151;123;137;142;124;166;122 02:53:56 INFO - PROCESS | 1683 | |2;audio-dft;196;196;203;288;276;199;199;249;193;195 02:53:56 INFO - PROCESS | 1683 | |3;audio-fft;69;81;76;150;78;85;83;100;131;68 02:53:56 INFO - PROCESS | 1683 | |4;audio-oscillator;76;82;129;78;85;94;141;100;92;117 02:53:56 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;88;103;89;84;89;85;87;86;89;85 02:53:56 INFO - PROCESS | 1683 | |6;imaging-darkroom;148;96;118;152;132;104;152;89;99;151 02:53:56 INFO - PROCESS | 1683 | |7;imaging-desaturate;91;92;108;91;92;91;92;91;91;91 02:53:56 INFO - PROCESS | 1683 | |8;json-parse-financial;61;65;66;66;66;66;68;80;63;62 02:53:56 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;66;68;73;74;101;115;96;66;71;70 02:53:56 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;84;80;84;83;91;102;81;83;83;87 02:53:56 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;157;145;117;146;136;148;139;128;146;145 02:53:56 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;155;218;216;170;165;168;168;166;165;195 02:53:56 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;64;76;98;92;66;69;66;70;64;94 02:53:56 INFO - PROCESS | 1683 | __end_tp_report 02:53:56 INFO - PROCESS | 1683 | __start_cc_report 02:53:56 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1101 02:53:56 INFO - PROCESS | 1683 | __end_cc_report 02:53:56 INFO - PROCESS | 1683 | __startTimestamp1463738036139__endTimestamp 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | ------- Summary: start ------- 02:53:56 INFO - PROCESS | 1683 | Number of tests: 14 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:130.60 Median:119.00 stddev:26.79 (22.5%) stddev-sans-first:28.19 02:53:56 INFO - PROCESS | 1683 | Values: 121.0 105.0 162.0 175.0 169.0 115.0 110.0 116.0 116.0 117.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:146.00 stddev:15.94 (10.9%) stddev-sans-first:16.44 02:53:56 INFO - PROCESS | 1683 | Values: 150.0 123.0 155.0 151.0 123.0 137.0 142.0 124.0 166.0 122.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:219.40 Median:201.00 stddev:36.93 (18.4%) stddev-sans-first:38.19 02:53:56 INFO - PROCESS | 1683 | Values: 196.0 196.0 203.0 288.0 276.0 199.0 199.0 249.0 193.0 195.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:92.10 Median:77.00 stddev:27.40 (35.6%) stddev-sans-first:27.76 02:53:56 INFO - PROCESS | 1683 | Values: 69.0 81.0 76.0 150.0 78.0 85.0 83.0 100.0 131.0 68.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:99.40 Median:80.00 stddev:22.40 (28.0%) stddev-sans-first:22.10 02:53:56 INFO - PROCESS | 1683 | Values: 76.0 82.0 129.0 78.0 85.0 94.0 141.0 100.0 92.0 117.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:87.50 stddev:5.42 (6.2%) stddev-sans-first:5.75 02:53:56 INFO - PROCESS | 1683 | Values: 88.0 103.0 89.0 84.0 89.0 85.0 87.0 86.0 89.0 85.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:124.10 Median:152.00 stddev:25.83 (17.0%) stddev-sans-first:25.91 02:53:56 INFO - PROCESS | 1683 | Values: 148.0 96.0 118.0 152.0 132.0 104.0 152.0 89.0 99.0 151.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:93.00 Median:91.00 stddev:5.29 (5.8%) stddev-sans-first:5.56 02:53:56 INFO - PROCESS | 1683 | Values: 91.0 92.0 108.0 91.0 92.0 91.0 92.0 91.0 91.0 91.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:5.27 (8.0%) stddev-sans-first:5.23 02:53:56 INFO - PROCESS | 1683 | Values: 61.0 65.0 66.0 66.0 66.0 66.0 68.0 80.0 63.0 62.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:70.50 stddev:17.40 (24.7%) stddev-sans-first:17.70 02:53:56 INFO - PROCESS | 1683 | Values: 66.0 68.0 73.0 74.0 101.0 115.0 96.0 66.0 71.0 70.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:83.50 stddev:6.48 (7.8%) stddev-sans-first:6.84 02:53:56 INFO - PROCESS | 1683 | Values: 84.0 80.0 84.0 83.0 91.0 102.0 81.0 83.0 83.0 87.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:145.50 stddev:11.35 (7.8%) stddev-sans-first:10.40 02:53:56 INFO - PROCESS | 1683 | Values: 157.0 145.0 117.0 146.0 136.0 148.0 139.0 128.0 146.0 145.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:169.00 stddev:22.62 (13.4%) stddev-sans-first:22.32 02:53:56 INFO - PROCESS | 1683 | Values: 155.0 218.0 216.0 170.0 165.0 168.0 168.0 166.0 165.0 195.0 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:73.00 stddev:13.49 (18.5%) stddev-sans-first:13.60 02:53:56 INFO - PROCESS | 1683 | Values: 64.0 76.0 98.0 92.0 66.0 69.0 66.0 70.0 64.0 94.0 02:53:56 INFO - PROCESS | 1683 | -------- Summary: end -------- 02:53:56 INFO - PROCESS | 1683 | 02:53:56 INFO - TEST-INFO | 1683: exit 0 02:53:56 INFO - TEST-OK | kraken | took 60088ms 02:53:56 INFO - SUITE-END | took 1171s 02:53:57 INFO - Completed test suite (00:19:31) 02:53:57 INFO - javascript benchmark 02:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3415.897523074308, 3452.0851974226825, 3507.0180349502148, 3525.594556625987, 3564.0377098183476, 5481.506664400204, 5833.212516310292, 5833.3874943130995, 5855.443732845373, 5858.091995740661, 5804.477597016267, 5834.037383831674, 5834.649921004732, 5866.677332746697, 5875.76496940123, 5229.947700522994, 5250.396204436501, 5288.867778305535, 5303.098473259555, 5304.36347638282, 5153.510416510426, 5257.342832145981, 5280.867978300535, 5357.223202635635, 5373.301470808789, 5296.655717378378, 5324.520793128618, 5329.733513324338, 5351.839444816642, 5385.838424847261, 5282.894342113155, 5301.019311427379, 5304.734763261821, 5325.3875804282225, 5359.517643412111, 5021.648484606079, 5089.567386772129, 5146.794128234867, 5251.684898906078, 5284.5772338212855, 4864.708117512925, 5544.251526043973, 5634.183043458716, 5657.603967722261, 5658.490735833795, 6255.06174073888, 6288.779892703734, 6303.054541818764, 6303.275123360826, 6307.905381419282, 6183.845403864894, 6229.501639868845, 6268.247810262752, 6326.2724786649205, 6330.0821380899515, 5956.642601443928, 5962.34414214436, 5974.103884417285, 5977.282726072855, 6014.669193194372, 6310.747570097236, 6330.651814150174, 6334.5249106317215, 6337.524685648595, 6339.0, 6036.0750576275, 6197.659128747872, 6201.0388389799655, 6252.218472690914, 6291.245050593958, 6294.685265736694, 6297.8110656679455, 6304.369563043659, 6331.2085989251345, 6333.36666333363, 6129.847850912788, 6305.0, 6308.022256550242, 6310.274318453345, 6313.55805093639, 5610.0, 6252.374762523711, 6289.0252010938375, 6305.3379395163765, 6308.8422789429715, 3898.3372826618975, 4742.1227072991605, 4964.429090654621, 4987.775550100254, 5003.924941125886, 4355.455568053993, 4376.474823021194, 4477.70894891831, 4493.438320209973, 4517.616002639812, 5638.295213098363, 5708.229389032427, 5883.235179426732, 5883.970580147157, 5920.644761314335, 6273.153124328157, 6287.0, 6300.558960872787, 6308.7476500940365, 6324.08300796382, 5690.089585666274, 5816.2148110005455, 5880.882382352329, 5898.0, 5904.114382842522, 5470.972645136829, 5472.0, 5497.257870187474, 5497.670139791625, 5531.6957567333375, 6419.325970773001, 6431.871362572722, 6440.291567927524, 6463.8060858173385, 6471.935280647133, 6215.65813880241, 6249.406306400884, 6306.905396419149, 6308.842278943063, 6312.905306420499, 6408.359164083741, 6418.839529011812, 6452.709628066842, 6462.676866156579, 6475.061116138039, 6273.090401891609, 6315.652639104894, 6322.996576626066, 6325.778597749057, 6334.809955701337, 6136.417040381157, 6183.690815459119, 6238.407351301619, 6297.433231009231, 6321.399467050623, 4829.541193586604, 6007.579469437273, 6221.502279817513, 6252.5935814171935, 6259.780907668392, 6211.16149319836, 6248.343923887926, 6256.593321434092, 6257.0, 6289.842753931189, 5891.882162356643, 6023.608465449732, 6027.336992930686, 6084.756609735561, 6112.083187521907, 6195.201657898975, 6235.3452887446165, 6249.937500624936, 6269.592476489013, 6276.717547710273, 5300.920486192633, 5862.091375836752, 6174.938250617616, 6188.009918413032, 6192.0], "value": 5759.546527958912, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.4065839675597, 544.9564084777651, 548.7228949380562, 553.3802141601407, 645.1612903225805, 27163.18510444685, 30219.395612087774, 37511.812440937756, 37801.62198378012, 37866.62133378666, 32858.342833143324, 34354.828225858895, 38882.8055859721, 40150.59849401505, 40811.183776324455, 9420.481873496972, 9647.75880602987, 9650.5174741263, 9659.661911833087, 9704.175145112638, 9548.092931171528, 9753.90246097537, 9759.609615615367, 9778.559964801565, 9810.607575696964, 9750.36622619531, 9820.459874706889, 9832.852507212398, 9841.26190535709, 9870.802583948316, 9709.41743495389, 9779.364341317792, 9801.754956126082, 9826.1156495915, 9869.950650246774, 9555.518894571353, 9657.275704322205, 9658.517074146264, 9658.75853103671, 9659.806803863954, 39107.60892391068, 39318.0, 39440.80279598612, 39494.60505394938, 39539.8023009886, 2738.3701748597737, 3122.35991621717, 3221.4201443740117, 3254.2189874429964, 3260.9347813043605, 29365.853170734008, 30109.548356774667, 30459.847700761355, 30632.0, 31040.22399440032, 2753.105240796749, 2779.0551212587616, 2801.635787347632, 2867.4121805029918, 2914.2714321419644, 391650.0, 392713.036434816, 393465.0, 397396.0130199359, 398886.0, 38148.61851381506, 66563.0, 67571.66214168898, 67602.66198668975, 71090.0, 37797.81101094532, 37843.81078094592, 38174.23651526954, 38206.0, 38235.0, 15394.615134621725, 15702.528924132293, 15759.842401576067, 15764.448244311623, 15799.0, 13049.869501305055, 13164.210147391188, 13164.539241126515, 13169.144005639795, 13194.802077968838, 8396.160383961676, 8421.399934012641, 8480.279176270085, 8591.6992905248, 8646.13538646143, 3496.30073985204, 3577.499150118985, 3579.427291633326, 3617.0957260684827, 3627.2745450909397, 976.2287792643732, 1023.9385636861663, 1070.1920050361928, 1102.2229328323674, 1149.83327417524, 29981.550276745867, 30342.84828575843, 30348.544771827997, 30433.934812281906, 30621.387572248877, 876.9429987050821, 1002.3935519011039, 1084.6312253833735, 1129.8249820187077, 1213.7511810078913, 15004.949653524367, 15325.540233793005, 15339.769903451457, 15703.371865125268, 15708.293126809322, 634912.0, 637404.0, 644152.0, 645047.0, 646778.0, 60286.0, 60381.0, 60854.0, 60918.39081609127, 60950.0, 1321.3921596065725, 1441.9495317663832, 1453.324204245031, 1476.2323591732454, 1483.5994281544138, 29395.265118372212, 29663.851680742322, 29729.108126756233, 30122.548161778028, 30434.695653044073, 44472.88817779452, 47832.282515762985, 51314.0, 51500.48499514957, 51663.0, 520909.0, 528718.0, 538075.0, 539003.0, 540118.0, 27372.726272737018, 27631.861840690668, 28036.43927121487, 28092.0, 28107.859460702566, 45583.0, 45662.543374567154, 45783.0, 47241.52758472371, 47508.049839002335, 36950.89147325585, 37754.43368349422, 37951.0, 38074.619253807105, 38598.0, 37644.0, 37913.62086379101, 38321.80839095786, 38390.2321953565, 38809.417858732704, 28576.57135143016, 36664.0, 37499.81250093732, 37819.81090094532, 37975.81012095032, 30585.54121688132, 31116.844415777778, 31658.050258492283, 31692.841535793097, 31744.6825531751, 20930.95345232702, 21793.455163621038, 24006.27981160568, 24222.51554968926, 24668.1366152191], "value": 18516.595769476102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.32409551952725, 403.6528585416541, 403.8344278845674, 409.3000968344131, 412.8947118484786, 16650.33398664052, 20421.795782042176, 20848.791512084874, 20890.0, 21125.47186320341, 20574.588508229826, 20864.791352086475, 21378.46553836155, 21935.561288774254, 22021.119155233773, 5768.451997060272, 5832.912506312408, 5986.28164620244, 6018.15745795589, 6031.668258245794, 4924.507549245082, 4982.402111746595, 5613.242212301348, 5960.463558279754, 6006.369331220225, 5875.0, 5911.763529458816, 5913.586048976574, 5922.407759224065, 5922.555808314372, 6001.399860014008, 6578.177727784027, 6589.769358072468, 6635.767748128841, 6655.600663960154, 5035.370578677665, 5730.0, 5830.5044071254, 5880.353161152269, 5917.674527900964, 24426.877865610735, 24720.07707552308, 24974.125905593217, 25007.62488562673, 25765.711714414203, 2192.0241052810193, 2237.5077482953725, 2303.8156947444163, 2315.131825565413, 2429.9878500607383, 9775.387061134905, 10025.749356266078, 10094.192464602815, 10355.79288414235, 10393.064624183784, 1657.3536320834885, 1811.529002459357, 1828.2321425001398, 1852.6109517001446, 1859.5537071102838, 81325.59337203336, 110911.0, 113089.43455282753, 115667.0, 117395.0, 11735.471903764352, 11929.926306632446, 11956.461959211856, 11962.162648614514, 12078.033757299396, 13463.596092117252, 14396.28018599066, 15005.099694018394, 15055.247237638294, 15154.545363638888, 7391.593462359514, 8646.6973655923, 8926.642934282556, 9092.954535227414, 9140.497272650067, 8503.57648070297, 9045.185933266037, 9047.728568142966, 9062.81874362509, 9100.726978190665, 3764.642358975893, 4714.811407543729, 4723.173444647173, 4723.338732577442, 4766.713997160182, 1882.2471011595471, 1932.806719328056, 1952.1508143957424, 1956.5891162855676, 1957.3442896629788, 915.1763412928418, 979.060102301784, 985.4875464758286, 1001.6594357918343, 1017.6641708236413, 20661.793382066287, 20912.581748364948, 20938.0, 21014.684779728315, 21248.575028499345, 980.3186785184371, 1003.0972125087334, 1012.9139023182964, 1017.1506791828906, 1017.5014243021014, 10986.505607247533, 10989.06592939609, 10997.450127493594, 11024.779504409868, 11083.057940075183, 607826.0, 617589.0, 625127.0, 638735.0, 638948.0, 123340.76659233472, 127388.36305818598, 128281.35859320831, 129207.41585168432, 131047.0, 1018.9286749927434, 1021.269792098653, 1035.342557475993, 1036.0520124086377, 1044.2248178097266, 18200.998945057618, 18620.44138675842, 18631.788933719265, 18772.3429679966, 18968.0515974198, 38897.88331234652, 49735.50264497309, 50458.0, 51651.93066586683, 55022.72488637531, 75922.24077759152, 77225.61387193252, 77973.0, 79636.00909977297, 80768.3846323082, 8164.510129392255, 8210.876836847572, 8241.629126689433, 8316.916830831615, 8567.443116197428, 11933.701657458632, 12284.938575307066, 12343.69140771488, 12523.0, 12527.93736031314, 4832.154372984784, 5302.39022512416, 7849.686012559434, 9679.08048735369, 10986.615468458565, 8955.910440895508, 10455.843162352723, 10603.151747859998, 10854.131669466582, 10962.945185274022, 6908.861822763416, 8253.711120111007, 11015.614453494089, 11029.895694142442, 11147.609833655782, 8040.115587285511, 8173.550454724809, 8205.753827385188, 8255.215754503313, 8486.787830304045, 8307.792305192419, 10975.670729878117, 11120.277181983145, 11156.330620162817, 11181.0], "value": 9492.490624310361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1612.6129728865071, 1633.8284480129587, 1885.7925628180897, 1941.941741747748, 2024.7064175694534, 7349.669264883079, 7707.845843083135, 8454.112318206591, 8859.557022148883, 8885.955570222148, 6754.560953538016, 8585.356098292637, 8673.132686731324, 8682.0, 8703.477791332525, 2439.499902519979, 2442.096424322994, 2448.681671382718, 2451.5587194305017, 2465.408302007514, 2424.3029380195167, 2491.813114016447, 2492.2149522900318, 2502.4995000999784, 2512.346789834638, 2466.099873546161, 2474.381404648838, 2481.8759062046825, 2498.1880888711153, 2502.4744803591266, 2433.914812981546, 2462.91379801707, 2475.6039033754605, 2484.465839844442, 2489.2781093482868, 2075.9065842037144, 2141.807237348646, 2254.531288239392, 2286.8284878634004, 2456.103522214397, 8673.262772664331, 8771.12288771124, 8798.032216456184, 8807.295416366675, 8819.647214111428, 5300.867478313035, 5370.5435038021815, 5460.153676180159, 5484.8354549363585, 5505.724713764296, 3514.1039035046156, 3559.6440355964455, 3608.981955090234, 3622.601513833476, 3646.5988741238443, 999.6601155607055, 1066.8346406307035, 1066.8506409102731, 1069.5187165775355, 1072.9034386905216, 11666.650000499998, 11816.468258928282, 11843.822342664867, 11850.585229516926, 11862.822057669142, 4755.2153894607, 4805.9443511776535, 4861.80552777892, 4877.487863774323, 4887.291342755351, 10136.493175341204, 10139.949300253451, 10141.847872281922, 10148.188144948534, 10157.035081667229, 5453.536449401766, 5465.535429488458, 5474.151506516497, 5491.066518691832, 5502.614816962854, 4389.758563278986, 4798.760061996886, 4887.0, 4915.803367865316, 4974.975125124423, 3988.4216788566077, 4046.979765101156, 4077.3894311746694, 4092.1406504633765, 4144.046869220036, 1342.731453709262, 1348.7235116801032, 1351.8715722006393, 1355.8101865738804, 1369.8767110959861, 723.0491903147449, 806.891069705594, 861.4099341950783, 871.3769654696796, 947.0245646983618, 5679.630823996427, 5745.425457454221, 5774.451427114417, 5846.152307915413, 6001.909971350433, 929.9581518831669, 955.8709574207533, 968.1286841842258, 1002.5839276700087, 1033.9224558158169, 3406.744494162948, 3854.4603755474254, 3884.3396622574232, 3944.8619298324993, 4028.697847661437, 9879.851802222973, 9900.900990989998, 10555.155587552978, 10900.50947707355, 10906.182036347305, 9907.603695852229, 10722.892771072346, 10730.087942524817, 10787.892121078845, 10829.729256768644, 7438.218987006287, 8265.793355166168, 8323.458975166595, 8342.874856877152, 8343.54110523927, 5521.337439507285, 5647.548196144381, 5720.8283751487525, 5780.826575202751, 5926.733297001559, 7824.843503129791, 8069.233422824822, 8078.6364613593705, 9528.666496672584, 9657.661981830603, 9807.215422766305, 9899.505024748878, 9929.404235745878, 9937.900620993698, 10098.394096354243, 7013.544119632207, 7079.327463890922, 7508.549487030796, 7508.774736757906, 7577.469577129768, 8255.752327430188, 8275.875861862198, 8341.95829020851, 8345.791355215926, 8372.497650141011, 7229.530080544748, 7390.29792169743, 7403.66683499233, 7455.589942552995, 7477.0, 7190.532615379983, 7369.0, 7380.483366164317, 7450.739224127129, 7487.812804679927, 7006.544574602634, 7025.192102908231, 7060.964695176492, 7062.364387205176, 7092.893606595802, 4760.262159365304, 4842.201036828884, 4888.706677599355, 4906.969536397397, 4937.679050861682, 4126.525449573217, 4893.657443978887, 4908.950910490849, 4971.552560269593, 5175.171972484384], "value": 4595.889544809524, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [247.65452194189106, 302.825875121805, 326.2659017211276, 329.515612050286, 331.5143315043461, 6019.0, 6579.276279609245, 6596.835079123024, 6692.698828552715, 6716.79849604512, 6041.154238406627, 6586.374294442032, 6614.040964060208, 6620.668966551665, 6649.368310010541, 3940.330143875548, 4114.382842573608, 4272.359146128075, 4699.506551812054, 4758.0721759256785, 3933.8819835404843, 4043.353063509839, 4808.639352048593, 4880.463149053619, 4923.852284431473, 4818.927716084261, 4906.877328066791, 4932.630052746058, 4933.481984391641, 4933.876653083666, 4924.089043526941, 4941.802327906879, 4951.752412379403, 4965.627577931669, 4974.776135073894, 3484.9651503485147, 4187.0, 4196.853110141131, 4204.411382406465, 4228.619424251801, 6165.013597824372, 6387.105805187278, 6399.848027355074, 6426.421622053991, 6438.227412710505, 5846.795362162304, 5890.617109887844, 5894.17481552583, 5895.587308888379, 5925.970370148165, 7126.964365178193, 7146.3568278855155, 7168.247334029904, 7169.605671688055, 7219.639018049076, 4726.550977657117, 4728.0, 4733.171694953369, 4757.833475828329, 4775.307580400822, 5991.310999235056, 7569.7350592729545, 7603.695852165907, 7618.809529761745, 7630.809229769245, 4520.50274469808, 4693.272542755878, 4693.577578017995, 4702.059588082398, 4839.637027222972, 4771.570558649738, 4784.808607655725, 4789.592884604847, 4804.399450068741, 4810.95189048112, 5700.401457846866, 5718.79984200551, 5733.541316694655, 5737.110747834093, 5767.509761670221, 7236.0, 7256.6734496947765, 7268.927310726931, 7272.272772722686, 7286.635668216568, 1632.616335161236, 1655.1558705060506, 1659.7427398753211, 1661.6012157082214, 1667.5497615643708, 863.4905405810601, 1012.7012531303283, 1050.6847945616285, 1052.1530168214508, 1059.8357254625546, 6554.868902621921, 6589.374009469093, 6635.601863888182, 6636.867262654817, 6678.764428580631, 7445.915143759756, 7449.366803821627, 7461.365783908429, 7489.925100749032, 7497.2877576630135, 5508.834734957958, 6454.903176452357, 6573.441257493071, 6735.158105236846, 6758.0, 3908.394198899175, 3969.206158768258, 3971.324874771296, 3973.5827738087087, 3977.5028121484816, 6721.361470660279, 7450.366718828852, 7822.765317040498, 7873.09459412175, 7897.565633890076, 7538.434617403716, 7817.140114587391, 7824.921750782533, 7830.4518683691595, 7838.255365740246, 7831.295183433518, 7876.606169691492, 7881.133075361706, 7933.761987140395, 7967.601619918981, 6007.0, 6272.905906411316, 7458.627068646438, 7488.3525624362555, 7489.176190618919, 7369.042024536776, 7422.146453157956, 7427.480076394817, 7434.182239953492, 7435.888461672971, 7566.281203285679, 7875.921240787748, 7892.658248097722, 7895.84208315842, 7901.486403383762, 4661.300804879295, 4694.06118776253, 4694.694844835075, 4707.340972263954, 4720.693154944917, 7523.473356864967, 7532.246775322424, 7535.623218839146, 7536.663634273393, 7538.3215510604305, 7204.747833825791, 7231.3130252625915, 7236.89144662841, 7242.855142897218, 7254.202037775735, 6915.273896240822, 7158.534695244793, 7209.963950180216, 7215.134183897966, 7228.530145540523, 7021.613811240431, 7027.894581581382, 7049.08361912948, 7058.61177635235, 7060.364567188978, 5825.70871456417, 7249.637518123967, 7255.129384473897, 7302.306280903305, 7305.817354566178, 7107.466939979626, 7135.82160445993, 7138.750143744944, 7140.642967851691, 7140.678669459783], "value": 5189.032657744618, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.5558553427066, 656.9080328753978, 657.4313219065507, 722.8518153778474, 742.2392048150645, 14767.409303627855, 14883.92558037211, 14964.401423943029, 15032.549023529284, 15047.172405517706, 13341.93329033356, 13638.045336826426, 13668.521601743942, 13681.65795855104, 13689.58931232062, 724.6775185042658, 891.6923661336829, 895.8342706599284, 913.5432283858071, 935.9719208423758, 782.1982467970319, 916.7295647783886, 924.9491277979708, 925.0795458518784, 925.5511077127621, 833.4124442268217, 958.324381311174, 977.9608815647401, 989.8564708117318, 997.316837965992, 949.539473355422, 976.1019861727228, 979.8040391921609, 982.8230918434679, 985.7929834734714, 702.7891632510226, 710.0378986473306, 714.9320814522612, 721.72935149319, 722.9927700722978, 15189.240537973168, 15235.162066086361, 15304.311305991258, 15305.38778448872, 15360.539183824503, 12864.29246391448, 12994.090413671047, 13078.41147148371, 13096.541621043218, 13100.737985240337, 9858.9507052465, 9900.752481187956, 10072.294939354248, 10127.797444051077, 10137.797244055151, 3464.9826750866087, 3511.613722490524, 3514.5431093957877, 3584.6415358463946, 3670.0274427276795, 64503.0, 69256.0, 77425.0, 78565.60717196492, 83942.58028709817, 8222.62998165084, 9103.68137115211, 9237.168654821098, 9403.811923761486, 9414.435133891988, 20490.692639610417, 20594.588108237753, 20634.690479642817, 20689.17243310281, 20700.068496917676, 7308.0, 7397.519161254501, 7437.628118594049, 7471.476996610294, 7493.775186744298, 3417.6069751978343, 3926.960730392717, 4007.338789099766, 4056.533498647634, 4122.0107174277955, 3224.822634755064, 3280.901572952815, 3293.2919422324317, 3299.785513941586, 3305.5702758641223, 658.499540349338, 660.8678264347054, 669.5480550628404, 681.2029924987776, 686.7356067913889, 467.37138548652007, 537.5565158743974, 586.2993722501654, 589.8790747896671, 600.0339453479894, 8020.318272946748, 8078.35373170145, 8198.344132469389, 8198.877016844752, 8240.711575094963, 536.0886492961903, 591.6243185577104, 594.3521561497988, 599.9500873471425, 604.9793689078499, 3586.1931065510053, 3823.598522155189, 3825.464434979105, 3998.8000599969887, 4040.939385909214, 90375.0, 93828.0, 94715.52642236745, 95205.047949521, 97226.0, 79536.0, 79916.0, 80362.0, 80559.0, 80660.19339806645, 51839.74080129575, 72537.6373118131, 72568.99999999894, 72851.63574182095, 74203.5159296811, 7747.496412733154, 7789.376849852111, 7950.24472675095, 8174.918250817654, 8236.382271329554, 36697.63302366942, 48454.757726211144, 49334.27330043431, 50455.0, 51169.488305117964, 53830.0, 58495.83008339724, 60512.0, 66889.32776680622, 67252.32747672657, 10846.403447810446, 10940.507677154388, 10955.397453140155, 10981.121510279318, 11394.54421823151, 11285.830712539155, 11736.88263117358, 11845.881541184477, 12095.637130886087, 12458.937705311415, 10995.945020274847, 11183.161262905152, 11232.606858759904, 11375.54497820078, 11519.02088322502, 11444.828327574927, 11479.483423246142, 11543.942280288546, 11789.351585662871, 11966.760664786481, 10951.616693415692, 11038.834417483584, 11231.831522527005, 11266.7746645065, 11441.656750297505, 9630.951845240728, 9733.270004749531, 9749.268804839523, 10018.799624007333, 10028.548715307683, 9481.0, 9592.184664303611, 9665.758356041155, 9675.03249675027, 9705.854412183682], "value": 6817.217589210565, "unit": "score"}], "name": "dromaeo_css", "value": 7402.945358567147, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 105.0, 162.0, 175.0, 169.0, 115.0, 110.0, 116.0, 116.0, 117.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 155.0, 151.0, 123.0, 137.0, 142.0, 124.0, 166.0, 122.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 196.0, 203.0, 288.0, 276.0, 199.0, 199.0, 249.0, 193.0, 195.0], "value": 219.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 76.0, 150.0, 78.0, 85.0, 83.0, 100.0, 131.0, 68.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 129.0, 78.0, 85.0, 94.0, 141.0, 100.0, 92.0, 117.0], "value": 99.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 103.0, 89.0, 84.0, 89.0, 85.0, 87.0, 86.0, 89.0, 85.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 96.0, 118.0, 152.0, 132.0, 104.0, 152.0, 89.0, 99.0, 151.0], "value": 124.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 108.0, 91.0, 92.0, 91.0, 92.0, 91.0, 91.0, 91.0], "value": 93.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 66.0, 66.0, 66.0, 66.0, 68.0, 80.0, 63.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 73.0, 74.0, 101.0, 115.0, 96.0, 66.0, 71.0, 70.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 84.0, 83.0, 91.0, 102.0, 81.0, 83.0, 83.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 145.0, 117.0, 146.0, 136.0, 148.0, 139.0, 128.0, 146.0, 145.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 218.0, 216.0, 170.0, 165.0, 168.0, 168.0, 166.0, 165.0, 195.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 98.0, 92.0, 66.0, 69.0, 66.0, 70.0, 64.0, 94.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1613.7, "alertThreshold": 2.0}]} 02:53:57 INFO - Return code: 0 02:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:53:57 ERROR - # TBPL SUCCESS # 02:53:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:57 INFO - 2016-05-20 02:53:57.429 screenresolution[1688:11005] starting screenresolution argv=screenresolution get 02:53:57 INFO - 2016-05-20 02:53:57.432 screenresolution[1688:11005] Display 0: 1600x1200x32@60 02:53:57 INFO - 2016-05-20 02:53:57.438 screenresolution[1689:11008] starting screenresolution argv=screenresolution list 02:53:57 INFO - Available Modes on Display 0 02:53:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:57 INFO - Intel Iris: 02:53:57 INFO - Chipset Model: Intel Iris 02:53:57 INFO - Type: GPU 02:53:57 INFO - Bus: Built-In 02:53:57 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:57 INFO - Vendor: Intel (0x8086) 02:53:57 INFO - Device ID: 0x0a2e 02:53:57 INFO - Revision ID: 0x0009 02:53:57 INFO - Displays: 02:53:57 INFO - Display: 02:53:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:57 INFO - Display Serial Number: 1600x1200 60 02:53:57 INFO - Main Display: Yes 02:53:57 INFO - Mirror: Off 02:53:57 INFO - Online: Yes 02:53:57 INFO - Rotation: Supported 02:53:57 INFO - Return code: 0 02:53:57 INFO - Running post-action listener: _resource_record_post_action 02:53:57 INFO - Running post-run listener: _resource_record_post_run 02:53:58 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 36709888; Write bytes: 656894464; Read time: 242; Write time: 1896 02:53:58 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 353073664; Write bytes: 347723776; Read time: 27484; Write time: 720 02:53:58 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 34895360; Write bytes: 299426304; Read time: 226; Write time: 1143 02:53:58 INFO - Running post-run listener: _upload_blobber_files 02:53:58 INFO - Blob upload gear active. 02:53:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:58 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 02:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:00 INFO - (blobuploader) - INFO - Done attempting. 02:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:54:01 INFO - (blobuploader) - INFO - Done attempting. 02:54:01 INFO - (blobuploader) - INFO - Iteration through files over. 02:54:01 INFO - Return code: 0 02:54:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:54:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:54:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec8b7cb73bffcb9ae10eed9326772dfb047ec14ae63ceec95edfbfd772aed0c142ef672ae01dbee449a6b866e5986662937094123d331f8ef25513e19d10f4b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36bc09b7eb9fbca353fe82d5338de7865e8bec61a41c79c4c11d9aa929452ddf56fc54fe90a144062e12ab2b79f13196f709005169591b68743fc8ff64a2a9f5"} 02:54:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:54:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:54:01 INFO - Contents: 02:54:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec8b7cb73bffcb9ae10eed9326772dfb047ec14ae63ceec95edfbfd772aed0c142ef672ae01dbee449a6b866e5986662937094123d331f8ef25513e19d10f4b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36bc09b7eb9fbca353fe82d5338de7865e8bec61a41c79c4c11d9aa929452ddf56fc54fe90a144062e12ab2b79f13196f709005169591b68743fc8ff64a2a9f5"} 02:54:01 INFO - Running post-run listener: copy_logs_to_upload_dir 02:54:01 INFO - Copying logs to upload dir... 02:54:01 INFO - mkdir: /builds/slave/test/build/upload/logs 02:54:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.453177 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-20 02:54:01.747270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 02:54:01.750955) ========= 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.WKprgsUmHE/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.BgsEZxOmKU/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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/Mozilla-Aurora/sha512/ec8b7cb73bffcb9ae10eed9326772dfb047ec14ae63ceec95edfbfd772aed0c142ef672ae01dbee449a6b866e5986662937094123d331f8ef25513e19d10f4b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36bc09b7eb9fbca353fe82d5338de7865e8bec61a41c79c4c11d9aa929452ddf56fc54fe90a144062e12ab2b79f13196f709005169591b68743fc8ff64a2a9f5"} build_url:https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010890 build_url: 'https://queue.taskcluster.net/v1/task/EGiU5KcWQaGX1huF_BEPgQ/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec8b7cb73bffcb9ae10eed9326772dfb047ec14ae63ceec95edfbfd772aed0c142ef672ae01dbee449a6b866e5986662937094123d331f8ef25513e19d10f4b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36bc09b7eb9fbca353fe82d5338de7865e8bec61a41c79c4c11d9aa929452ddf56fc54fe90a144062e12ab2b79f13196f709005169591b68743fc8ff64a2a9f5"}' ========= master_lag: 0.73 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 02:54:02.486866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:54:02.487212) ========= 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.WKprgsUmHE/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.BgsEZxOmKU/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.005216 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 02:54:02.528085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 02:54:02.528434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 02:54:02.528896) ========= ========= Total master_lag: 1.21 =========