builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0355 starttime: 1464909510.05 results: success (0) buildid: 20160602141735 builduid: 70706e1908e54dba95a3575b5e94187c revision: 277ad8a2a286a3666ad512aeb40adb05155ee745 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.053423) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.054293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.054597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.129291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.129717) ========= 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.iiJ582vG1B/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.TjPySPgOHe/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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-06-02 16:18:30-- 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% 252M=0s 2016-06-02 16:18:30 (252 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.482089 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.652177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.652578) ========= 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.iiJ582vG1B/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.TjPySPgOHe/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.025309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:30.704562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 16:18:30.704912) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 277ad8a2a286a3666ad512aeb40adb05155ee745 --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 277ad8a2a286a3666ad512aeb40adb05155ee745 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iiJ582vG1B/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.TjPySPgOHe/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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-06-02 16:18:30,790 truncating revision to first 12 chars 2016-06-02 16:18:30,790 Setting DEBUG logging. 2016-06-02 16:18:30,790 attempt 1/10 2016-06-02 16:18:30,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/277ad8a2a286?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 16:18:31,882 unpacking tar archive at: mozilla-aurora-277ad8a2a286/testing/mozharness/ program finished with exit code 0 elapsedTime=1.347079 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 16:18:32.072356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:32.072679) ========= script_repo_revision: 277ad8a2a286a3666ad512aeb40adb05155ee745 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:32.073078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:32.073370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 16:18:32.090027) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-02 16:18:32.090435) ========= /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.iiJ582vG1B/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.TjPySPgOHe/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:18:32 INFO - MultiFileLogger online at 20160602 16:18:32 in /builds/slave/test 16:18:32 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 16:18:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:32 INFO - {'append_to_log': False, 16:18:32 INFO - 'base_work_dir': '/builds/slave/test', 16:18:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:18:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:32 INFO - 'branch': 'Mozilla-Aurora', 16:18:32 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:32 INFO - 'config_files': ('talos/mac_config.py',), 16:18:32 INFO - 'default_actions': ('clobber', 16:18:32 INFO - 'read-buildbot-config', 16:18:32 INFO - 'download-and-extract', 16:18:32 INFO - 'populate-webroot', 16:18:32 INFO - 'create-virtualenv', 16:18:32 INFO - 'install', 16:18:32 INFO - 'run-tests'), 16:18:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:32 INFO - 'download_minidump_stackwalk': True, 16:18:32 INFO - 'download_symbols': 'ondemand', 16:18:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:32 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:32 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:32 INFO - 'installer_path': 'installer.exe', 16:18:32 INFO - 'log_level': 'info', 16:18:32 INFO - 'log_name': 'talos', 16:18:32 INFO - 'log_to_console': True, 16:18:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:18:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:18:32 INFO - 'opt_config_files': (), 16:18:32 INFO - 'pip_index': False, 16:18:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:32 INFO - 'cmd': ('bash', 16:18:32 INFO - '-c', 16:18:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:32 INFO - 'enabled': True, 16:18:32 INFO - 'halt_on_failure': False, 16:18:32 INFO - 'name': 'check_screen_resolution'},), 16:18:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:32 INFO - 'cmd': ('bash', 16:18:32 INFO - '-c', 16:18:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:32 INFO - 'enabled': True, 16:18:32 INFO - 'halt_on_failure': False, 16:18:32 INFO - 'name': 'check_screen_resolution'},), 16:18:32 INFO - 'run_cmd_checks_enabled': True, 16:18:32 INFO - 'sps_profile': False, 16:18:32 INFO - 'sps_profile_interval': 0, 16:18:32 INFO - 'suite': 'dromaeojs-e10s', 16:18:32 INFO - 'system_bits': '32', 16:18:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:32 INFO - 'title': 't-yosemite-r7-0355', 16:18:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:32 INFO - 'use_talos_json': True, 16:18:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:32 INFO - 'work_dir': 'build'} 16:18:32 INFO - ##### 16:18:32 INFO - ##### Running clobber step. 16:18:32 INFO - ##### 16:18:32 INFO - Running pre-action listener: _resource_record_pre_action 16:18:32 INFO - Running main action method: clobber 16:18:32 INFO - rmtree: /builds/slave/test/build 16:18:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:33 INFO - Running post-action listener: _resource_record_post_action 16:18:33 INFO - ##### 16:18:33 INFO - ##### Running read-buildbot-config step. 16:18:33 INFO - ##### 16:18:33 INFO - Running pre-action listener: _resource_record_pre_action 16:18:33 INFO - Running main action method: read_buildbot_config 16:18:33 INFO - Using buildbot properties: 16:18:33 INFO - { 16:18:33 INFO - "project": "", 16:18:33 INFO - "product": "firefox", 16:18:33 INFO - "script_repo_revision": "production", 16:18:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:18:33 INFO - "repository": "", 16:18:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:18:33 INFO - "buildid": "20160602141735", 16:18:33 INFO - "pgo_build": "False", 16:18:33 INFO - "basedir": "/builds/slave/test", 16:18:33 INFO - "buildnumber": 32, 16:18:33 INFO - "slavename": "t-yosemite-r7-0355", 16:18:33 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:18:33 INFO - "platform": "yosemite_r7", 16:18:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:18:33 INFO - "branch": "mozilla-aurora", 16:18:33 INFO - "repo_path": "releases/mozilla-aurora", 16:18:33 INFO - "revision": "277ad8a2a286a3666ad512aeb40adb05155ee745", 16:18:33 INFO - "stage_platform": "macosx64", 16:18:33 INFO - "builduid": "70706e1908e54dba95a3575b5e94187c", 16:18:33 INFO - "slavebuilddir": "test" 16:18:33 INFO - } 16:18:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 16:18:33 INFO - Running post-action listener: _resource_record_post_action 16:18:33 INFO - ##### 16:18:33 INFO - ##### Running download-and-extract step. 16:18:33 INFO - ##### 16:18:33 INFO - Running pre-action listener: _resource_record_pre_action 16:18:33 INFO - Running main action method: download_and_extract 16:18:33 INFO - mkdir: /builds/slave/test/build/tests 16:18: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')]} 16:18:33 INFO - https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:18:43 INFO - Downloaded 1199 bytes. 16:18:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 16:18:43 INFO - Using the following test package requirements: 16:18:43 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 16:18:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 16:18:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 16:18:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'jsshell-mac.zip'], 16:18:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 16:18:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 16:18:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 16:18:43 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 16:18:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 16:18:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 16:18:43 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 16:18:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:43 INFO - https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:18:48 INFO - Downloaded 18463811 bytes. 16:18:48 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'] 16:18:48 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 16:18:51 INFO - Return code: 0 16:18:51 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 16:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:51 INFO - https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 16:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:18:57 INFO - Downloaded 18463811 bytes. 16:18:57 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'] 16:18:57 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 16:19:00 INFO - Return code: 0 16:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:00 INFO - https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 16:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 16:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:19:02 INFO - Downloaded 10840145 bytes. 16:19:02 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'] 16:19:02 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 16:19:02 INFO - Return code: 0 16:19: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')]} 16:19:02 INFO - https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 16:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5C0kRReR7a6hl4kkZL_IA/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 16:19:07 INFO - Downloaded 114171200 bytes. 16:19:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:19:07 INFO - mkdir: /builds/slave/test/properties 16:19:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:07 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:07 INFO - Contents: 16:19:07 INFO - build_url:https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 16:19:07 INFO - Running post-action listener: _resource_record_post_action 16:19:07 INFO - Running post-action listener: set_extra_try_arguments 16:19:07 INFO - ##### 16:19:07 INFO - ##### Running populate-webroot step. 16:19:07 INFO - ##### 16:19:07 INFO - Running pre-action listener: _resource_record_pre_action 16:19:07 INFO - Running main action method: populate_webroot 16:19:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:19:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:19:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:19:07 INFO - '--tppagecycles', 16:19:07 INFO - '7'], 16:19:07 INFO - 'tests': ['tsvgm']}}, 16:19:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:19:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:19:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:19:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:19:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['damp', 'tps']}, 16:19:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'tests': ['damp', 'tps']}, 16:19:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['dromaeo_dom']}, 16:19:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['a11yr', 16:19:07 INFO - 'ts_paint', 16:19:07 INFO - 'tpaint', 16:19:07 INFO - 'sessionrestore', 16:19:07 INFO - 'sessionrestore_no_auto_restore', 16:19:07 INFO - 'tabpaint']}, 16:19:07 INFO - 'other-e10s': {'tests': ['a11yr', 16:19:07 INFO - 'ts_paint', 16:19:07 INFO - 'tpaint', 16:19:07 INFO - 'sessionrestore', 16:19:07 INFO - 'sessionrestore_no_auto_restore', 16:19:07 INFO - 'tabpaint']}, 16:19:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:19:07 INFO - 'ts_paint', 16:19:07 INFO - 'tpaint', 16:19:07 INFO - 'sessionrestore', 16:19:07 INFO - 'sessionrestore_no_auto_restore', 16:19:07 INFO - 'tabpaint']}, 16:19:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:19:07 INFO - 'ts_paint', 16:19:07 INFO - 'tpaint', 16:19:07 INFO - 'sessionrestore', 16:19:07 INFO - 'sessionrestore_no_auto_restore', 16:19:07 INFO - 'tabpaint']}, 16:19:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['a11yr', 16:19:07 INFO - 'ts_paint', 16:19:07 INFO - 'tpaint', 16:19:07 INFO - 'sessionrestore', 16:19:07 INFO - 'sessionrestore_no_auto_restore', 16:19:07 INFO - 'tabpaint']}, 16:19:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['a11yr', 16:19:07 INFO - 'ts_paint', 16:19:07 INFO - 'tpaint', 16:19:07 INFO - 'sessionrestore', 16:19:07 INFO - 'sessionrestore_no_auto_restore', 16:19:07 INFO - 'tabpaint']}, 16:19:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['tsvgx', 16:19:07 INFO - 'tsvgr_opacity', 16:19:07 INFO - 'tart', 16:19:07 INFO - 'tscrollx', 16:19:07 INFO - 'cart']}, 16:19:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:19:07 INFO - 'tsvgr_opacity', 16:19:07 INFO - 'tart', 16:19:07 INFO - 'tscrollx', 16:19:07 INFO - 'cart']}, 16:19:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'talos_options': ['--disable-e10s'], 16:19:07 INFO - 'tests': ['tp5o']}, 16:19:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'tests': ['tp5o']}, 16:19:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'talos_options': ['--disable-e10s', 16:19:07 INFO - '--xperf_path', 16:19:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:07 INFO - 'tests': ['tp5n']}, 16:19:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:07 INFO - 'talos_options': ['--xperf_path', 16:19:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:07 INFO - 'tests': ['tp5n']}}, 16:19:07 INFO - 'talos.zip': {'path': '', 16:19:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:19:07 INFO - Running post-action listener: _resource_record_post_action 16:19:07 INFO - ##### 16:19:07 INFO - ##### Running create-virtualenv step. 16:19:07 INFO - ##### 16:19:07 INFO - Running pre-action listener: _resource_record_pre_action 16:19:07 INFO - Running main action method: create_virtualenv 16:19:07 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:19:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:08 INFO - Using real prefix '/tools/python27' 16:19:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:11 INFO - Installing pip.................done. 16:19:11 INFO - Return code: 0 16:19:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:11 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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:11 INFO - 'HOME': '/Users/cltbld', 16:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:11 INFO - 'LOGNAME': 'cltbld', 16:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:11 INFO - 'MOZ_NO_REMOTE': '1', 16:19:11 INFO - 'NO_EM_RESTART': '1', 16:19:11 INFO - 'PAGER': '/bin/cat', 16:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:11 INFO - 'PWD': '/builds/slave/test', 16:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:11 INFO - 'SHELL': '/bin/bash', 16:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:11 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:11 INFO - 'USER': 'cltbld', 16:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:11 INFO - 'XPC_FLAGS': '0x0', 16:19:11 INFO - 'XPC_SERVICE_NAME': '0', 16:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:19:11 INFO - Cleaning up... 16:19:11 INFO - Return code: 0 16:19:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:11 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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:11 INFO - 'HOME': '/Users/cltbld', 16:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:11 INFO - 'LOGNAME': 'cltbld', 16:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:11 INFO - 'MOZ_NO_REMOTE': '1', 16:19:11 INFO - 'NO_EM_RESTART': '1', 16:19:11 INFO - 'PAGER': '/bin/cat', 16:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:11 INFO - 'PWD': '/builds/slave/test', 16:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:11 INFO - 'SHELL': '/bin/bash', 16:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:11 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:11 INFO - 'USER': 'cltbld', 16:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:11 INFO - 'XPC_FLAGS': '0x0', 16:19:11 INFO - 'XPC_SERVICE_NAME': '0', 16:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:12 INFO - Downloading/unpacking psutil>=0.7.1 16:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:15 INFO - Installing collected packages: psutil 16:19:15 INFO - Running setup.py install for psutil 16:19:15 INFO - building 'psutil._psutil_osx' extension 16:19:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:19:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:19:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:19:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:19:15 INFO - building 'psutil._psutil_posix' extension 16:19:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:19:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:19:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:19:16 INFO - ^ 16:19:16 INFO - 1 warning generated. 16:19:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:19:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:16 INFO - Successfully installed psutil 16:19:16 INFO - Cleaning up... 16:19:16 INFO - Return code: 0 16:19:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:19:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:16 INFO - 'HOME': '/Users/cltbld', 16:19:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:16 INFO - 'LOGNAME': 'cltbld', 16:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:16 INFO - 'MOZ_NO_REMOTE': '1', 16:19:16 INFO - 'NO_EM_RESTART': '1', 16:19:16 INFO - 'PAGER': '/bin/cat', 16:19:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:16 INFO - 'PWD': '/builds/slave/test', 16:19:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:16 INFO - 'SHELL': '/bin/bash', 16:19:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:16 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:16 INFO - 'USER': 'cltbld', 16:19:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:16 INFO - 'XPC_FLAGS': '0x0', 16:19:16 INFO - 'XPC_SERVICE_NAME': '0', 16:19:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:19:19 INFO - Installing collected packages: mozsystemmonitor 16:19:19 INFO - Running setup.py install for mozsystemmonitor 16:19:19 INFO - Successfully installed mozsystemmonitor 16:19:19 INFO - Cleaning up... 16:19:19 INFO - Return code: 0 16:19:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:19:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:19 INFO - 'HOME': '/Users/cltbld', 16:19:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:19 INFO - 'LOGNAME': 'cltbld', 16:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:19 INFO - 'MOZ_NO_REMOTE': '1', 16:19:19 INFO - 'NO_EM_RESTART': '1', 16:19:19 INFO - 'PAGER': '/bin/cat', 16:19:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:19 INFO - 'PWD': '/builds/slave/test', 16:19:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:19 INFO - 'SHELL': '/bin/bash', 16:19:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:19 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:19 INFO - 'USER': 'cltbld', 16:19:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:19 INFO - 'XPC_FLAGS': '0x0', 16:19:19 INFO - 'XPC_SERVICE_NAME': '0', 16:19:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:21 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:23 INFO - Downloading docopt-0.6.1.tar.gz 16:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:23 INFO - Running setup.py install for blobuploader 16:19:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:23 INFO - Running setup.py install for requests 16:19:23 INFO - Running setup.py install for docopt 16:19:23 INFO - Successfully installed blobuploader requests docopt 16:19:23 INFO - Cleaning up... 16:19:24 INFO - Return code: 0 16:19:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19: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')]} 16:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:24 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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:19:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:24 INFO - 'HOME': '/Users/cltbld', 16:19:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:24 INFO - 'LOGNAME': 'cltbld', 16:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:24 INFO - 'MOZ_NO_REMOTE': '1', 16:19:24 INFO - 'NO_EM_RESTART': '1', 16:19:24 INFO - 'PAGER': '/bin/cat', 16:19:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:24 INFO - 'PWD': '/builds/slave/test', 16:19:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:24 INFO - 'SHELL': '/bin/bash', 16:19:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:24 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:24 INFO - 'USER': 'cltbld', 16:19:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:24 INFO - 'XPC_FLAGS': '0x0', 16:19:24 INFO - 'XPC_SERVICE_NAME': '0', 16:19:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-GGKNm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-rqoE4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-LqCvpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-m_foed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-DFcULO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-3E4LMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:24 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-k75iKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-fU1iLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-3_xN32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-BMgnT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-cfX_qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-UY8lEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-omlUi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-pIi0jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-YYYRUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-zh30uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:25 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-i267ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:26 INFO - Running setup.py install for manifestparser 16:19:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:26 INFO - Running setup.py install for mozcrash 16:19:26 INFO - Running setup.py install for mozdebug 16:19:26 INFO - Running setup.py install for mozdevice 16:19:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:26 INFO - Running setup.py install for mozfile 16:19:26 INFO - Running setup.py install for mozhttpd 16:19:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:26 INFO - Running setup.py install for mozinfo 16:19:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Running setup.py install for mozInstall 16:19:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Running setup.py install for mozleak 16:19:27 INFO - Running setup.py install for mozlog 16:19:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Running setup.py install for moznetwork 16:19:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Running setup.py install for mozprocess 16:19:27 INFO - Running setup.py install for mozprofile 16:19:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:28 INFO - Running setup.py install for mozrunner 16:19:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:28 INFO - Running setup.py install for mozscreenshot 16:19:28 INFO - Running setup.py install for moztest 16:19:28 INFO - Running setup.py install for mozversion 16:19:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:28 INFO - Cleaning up... 16:19:28 INFO - Return code: 0 16:19:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:28 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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:28 INFO - 'HOME': '/Users/cltbld', 16:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:28 INFO - 'LOGNAME': 'cltbld', 16:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:28 INFO - 'MOZ_NO_REMOTE': '1', 16:19:28 INFO - 'NO_EM_RESTART': '1', 16:19:28 INFO - 'PAGER': '/bin/cat', 16:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:28 INFO - 'PWD': '/builds/slave/test', 16:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:28 INFO - 'SHELL': '/bin/bash', 16:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:28 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:28 INFO - 'USER': 'cltbld', 16:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:28 INFO - 'XPC_FLAGS': '0x0', 16:19:28 INFO - 'XPC_SERVICE_NAME': '0', 16:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:28 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Yo6C6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-zSCFBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-KWUwpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-bA9nOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-_k44Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-fQrtEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-bE2x6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-d8T9SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-BHSfdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-wak4KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:29 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-Q6FAvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:30 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-2C4Cet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:30 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-YML9Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:30 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-D1u2vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:30 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-BmOO08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:30 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-szWkWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:30 INFO - Running setup.py (path:/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/pip-CcOnq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:19:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:33 INFO - Downloading blessings-1.6.tar.gz 16:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:33 INFO - Installing collected packages: blessings 16:19:33 INFO - Running setup.py install for blessings 16:19:33 INFO - Successfully installed blessings 16:19:33 INFO - Cleaning up... 16:19:33 INFO - Return code: 0 16:19:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:33 INFO - Reading from file tmpfile_stdout 16:19:33 INFO - Current package versions: 16:19:33 INFO - blessings == 1.6 16:19:33 INFO - blobuploader == 1.2.4 16:19:33 INFO - docopt == 0.6.1 16:19:33 INFO - manifestparser == 1.1 16:19:33 INFO - mozInstall == 1.12 16:19:33 INFO - mozcrash == 0.17 16:19:33 INFO - mozdebug == 0.1 16:19:33 INFO - mozdevice == 0.48 16:19:33 INFO - mozfile == 1.2 16:19:33 INFO - mozhttpd == 0.7 16:19:33 INFO - mozinfo == 0.9 16:19:33 INFO - mozleak == 0.1 16:19:33 INFO - mozlog == 3.1 16:19:33 INFO - moznetwork == 0.27 16:19:33 INFO - mozprocess == 0.22 16:19:33 INFO - mozprofile == 0.28 16:19:33 INFO - mozrunner == 6.11 16:19:33 INFO - mozscreenshot == 0.1 16:19:33 INFO - mozsystemmonitor == 0.0 16:19:33 INFO - moztest == 0.7 16:19:33 INFO - mozversion == 1.4 16:19:33 INFO - psutil == 3.1.1 16:19:33 INFO - requests == 1.2.3 16:19:33 INFO - wsgiref == 0.1.2 16:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19: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')]} 16:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19: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')]} 16:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:33 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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:33 INFO - 'HOME': '/Users/cltbld', 16:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:33 INFO - 'LOGNAME': 'cltbld', 16:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:33 INFO - 'MOZ_NO_REMOTE': '1', 16:19:33 INFO - 'NO_EM_RESTART': '1', 16:19:33 INFO - 'PAGER': '/bin/cat', 16:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:33 INFO - 'PWD': '/builds/slave/test', 16:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:33 INFO - 'SHELL': '/bin/bash', 16:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:33 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:33 INFO - 'USER': 'cltbld', 16:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:33 INFO - 'XPC_FLAGS': '0x0', 16:19:33 INFO - 'XPC_SERVICE_NAME': '0', 16:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:19:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:19:34 INFO - Cleaning up... 16:19:34 INFO - Return code: 0 16:19:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:34 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 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:34 INFO - 'HOME': '/Users/cltbld', 16:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:34 INFO - 'LOGNAME': 'cltbld', 16:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:34 INFO - 'MOZ_NO_REMOTE': '1', 16:19:34 INFO - 'NO_EM_RESTART': '1', 16:19:34 INFO - 'PAGER': '/bin/cat', 16:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:34 INFO - 'PWD': '/builds/slave/test', 16:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:34 INFO - 'SHELL': '/bin/bash', 16:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:34 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:34 INFO - 'USER': 'cltbld', 16:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:34 INFO - 'XPC_FLAGS': '0x0', 16:19:34 INFO - 'XPC_SERVICE_NAME': '0', 16:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:34 INFO - Downloading/unpacking jsonschema 16:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:37 INFO - Downloading/unpacking functools32 (from jsonschema) 16:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:37 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:37 INFO - warning: no files found matching '*.txt' 16:19:37 INFO - no previously-included directories found matching 'build' 16:19:37 INFO - no previously-included directories found matching 'dist' 16:19:37 INFO - no previously-included directories found matching '.git*' 16:19:37 INFO - Installing collected packages: jsonschema, functools32 16:19:37 INFO - Running setup.py install for functools32 16:19:37 INFO - warning: no files found matching '*.txt' 16:19:37 INFO - no previously-included directories found matching 'build' 16:19:37 INFO - no previously-included directories found matching 'dist' 16:19:37 INFO - no previously-included directories found matching '.git*' 16:19:38 INFO - Successfully installed jsonschema functools32 16:19:38 INFO - Cleaning up... 16:19:38 INFO - Return code: 0 16:19:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b946a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b956420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbfac59190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, '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.iiJ582vG1B/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.TjPySPgOHe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:19:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:19:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:38 INFO - 'HOME': '/Users/cltbld', 16:19:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:38 INFO - 'LOGNAME': 'cltbld', 16:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:38 INFO - 'MOZ_NO_REMOTE': '1', 16:19:38 INFO - 'NO_EM_RESTART': '1', 16:19:38 INFO - 'PAGER': '/bin/cat', 16:19:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:38 INFO - 'PWD': '/builds/slave/test', 16:19:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:38 INFO - 'SHELL': '/bin/bash', 16:19:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:19:38 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:19:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:38 INFO - 'USER': 'cltbld', 16:19:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:38 INFO - 'XPC_FLAGS': '0x0', 16:19:38 INFO - 'XPC_SERVICE_NAME': '0', 16:19:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:38 INFO - Downloading/unpacking flake8 16:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:19:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:19:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:19:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:42 INFO - no previously-included directories found matching 'docs/_build' 16:19:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:19:42 INFO - Running setup.py install for pep8 16:19:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:42 INFO - no previously-included directories found matching 'docs/_build' 16:19:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:19:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:19:42 INFO - Cleaning up... 16:19:42 INFO - Return code: 0 16:19:42 INFO - Running post-action listener: _resource_record_post_action 16:19:42 INFO - Running post-action listener: _start_resource_monitoring 16:19:42 INFO - Starting resource monitoring. 16:19:42 INFO - ##### 16:19:42 INFO - ##### Running install step. 16:19:42 INFO - ##### 16:19:42 INFO - Running pre-action listener: _resource_record_pre_action 16:19:42 INFO - Running main action method: install 16:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:42 INFO - Reading from file tmpfile_stdout 16:19:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:42 INFO - Reading from file tmpfile_stdout 16:19:42 INFO - Output received: 16:19:42 INFO - Usage: mozinstall [options] installer 16:19:42 INFO - Options: 16:19:42 INFO - -h, --help show this help message and exit 16:19:42 INFO - -d DEST, --destination=DEST 16:19:42 INFO - Directory to install application into. [default: 16:19:42 INFO - "/builds/slave/test"] 16:19:42 INFO - --app=APP Application being installed. [default: firefox] 16:19:42 INFO - mkdir: /builds/slave/test/build/application 16:19:42 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'] 16:19:42 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 16:20:14 INFO - Reading from file tmpfile_stdout 16:20:14 INFO - Output received: 16:20:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:20:14 INFO - Running post-action listener: _resource_record_post_action 16:20:14 INFO - ##### 16:20:14 INFO - ##### Running run-tests step. 16:20:14 INFO - ##### 16:20:14 INFO - Running pre-action listener: _resource_record_pre_action 16:20:14 INFO - Running main action method: run_tests 16:20:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:20:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:20:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:20:14 INFO - 2016-06-02 16:20:14.271 screenresolution[1662:8297] starting screenresolution argv=screenresolution get 16:20:14 INFO - 2016-06-02 16:20:14.273 screenresolution[1662:8297] Display 0: 1600x1200x32@60 16:20:14 INFO - 2016-06-02 16:20:14.279 screenresolution[1663:8299] starting screenresolution argv=screenresolution list 16:20:14 INFO - Available Modes on Display 0 16:20:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:20:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:20:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:20:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:20:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:20:14 INFO - Intel Iris: 16:20:14 INFO - Chipset Model: Intel Iris 16:20:14 INFO - Type: GPU 16:20:14 INFO - Bus: Built-In 16:20:14 INFO - VRAM (Dynamic, Max): 1536 MB 16:20:14 INFO - Vendor: Intel (0x8086) 16:20:14 INFO - Device ID: 0x0a2e 16:20:14 INFO - Revision ID: 0x0009 16:20:14 INFO - Displays: 16:20:14 INFO - Display: 16:20:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:20:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:20:14 INFO - Display Serial Number: 1600x1200 60 16:20:14 INFO - Main Display: Yes 16:20:14 INFO - Mirror: Off 16:20:14 INFO - Online: Yes 16:20:14 INFO - Rotation: Supported 16:20:14 INFO - Return code: 0 16:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:14 INFO - Python 2.7.3 16:20:14 INFO - Return code: 0 16:20:14 INFO - grabbing minidump binary from tooltool 16:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:14 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 0x10b7e5e00>, '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 0x10b64edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b7e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:20:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:20:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:14 INFO - Return code: 0 16:20:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:20:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:20:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:20:15 INFO - Return code: 0 16:20:15 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/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--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 16:20:15 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/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0355 --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 16:20:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iiJ582vG1B/Render', 16:20:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:15 INFO - 'HOME': '/Users/cltbld', 16:20:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:15 INFO - 'LOGNAME': 'cltbld', 16:20:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:15 INFO - 'MOZ_NO_REMOTE': '1', 16:20:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:15 INFO - 'NO_EM_RESTART': '1', 16:20:15 INFO - 'PAGER': '/bin/cat', 16:20:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:15 INFO - 'PWD': '/builds/slave/test', 16:20:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:15 INFO - 'SHELL': '/bin/bash', 16:20:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjPySPgOHe/Listeners', 16:20:15 INFO - 'TMPDIR': '/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/', 16:20:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:15 INFO - 'USER': 'cltbld', 16:20:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:15 INFO - 'XPC_FLAGS': '0x0', 16:20:15 INFO - 'XPC_SERVICE_NAME': '0', 16:20:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:20:15 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/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0355', '--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 16:20:15 INFO - mozversion application_buildid: 20160602141735 16:20:15 INFO - mozversion application_changeset: 277ad8a2a286a3666ad512aeb40adb05155ee745 16:20:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:20:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:15 INFO - mozversion application_name: Firefox 16:20:15 INFO - mozversion application_remotingname: firefox-dev 16:20:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:20:15 INFO - mozversion application_vendor: Mozilla 16:20:15 INFO - mozversion application_version: 48.0a2 16:20:15 INFO - mozversion platform_buildid: 20160602141735 16:20:15 INFO - mozversion platform_changeset: 277ad8a2a286a3666ad512aeb40adb05155ee745 16:20:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:20:15 INFO - mozversion platform_version: 48.0a2 16:20:15 INFO - using testdate: 1464909615 16:20:15 INFO - actual date: 1464909615 16:20:15 INFO - starting webserver on 'localhost:49270' 16:20:15 INFO - SUITE-START | Running 2 tests 16:20:15 INFO - TEST-START | dromaeo_css 16:20:15 INFO - operating with platform_type : mac_ 16:20:15 INFO - Initialising browser for dromaeo_css test... 16:20:15 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpofVA4o/profile http://localhost:49270/getInfo.html) 16:20:18 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 16:20:18 INFO - PROCESS | 1681 | colorDepth:24 16:20:18 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 16:20:18 INFO - PROCESS | 1681 | __metrics 16:20:18 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 16:20:19 INFO - TEST-INFO | 1681: exit 0 16:20:19 INFO - Browser initialized. 16:20:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:19 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmpofVA4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:31 INFO - PROCESS | 1684 | RSS: Main: 220581888 16:20:31 INFO - PROCESS | 1684 | 16:21:20 INFO - PROCESS | 1684 | 1464909680931 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:23:31 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:23:33 INFO - PROCESS | 1684 | RSS: Main: 231411712 16:23:33 INFO - PROCESS | 1684 | 16:26:35 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:26:35 INFO - PROCESS | 1684 | RSS: Main: 243236864 16:26:35 INFO - PROCESS | 1684 | 16:29:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:29:38 INFO - PROCESS | 1684 | RSS: Main: 245227520 16:29:38 INFO - PROCESS | 1684 | 16:32:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:32:40 INFO - PROCESS | 1684 | RSS: Main: 247087104 16:32:40 INFO - PROCESS | 1684 | 16:35:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:35:43 INFO - PROCESS | 1684 | RSS: Main: 249843712 16:35:43 INFO - PROCESS | 1684 | 16:38:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:38:46 INFO - PROCESS | 1684 | RSS: Main: 250728448 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | __start_tp_report 16:38:46 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 16:38:46 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 16:38:46 INFO - PROCESS | 1684 | |i|pagename|runs| 16:38:46 INFO - PROCESS | 1684 | |0;dojo.html;3447.8103704296263;3495.650434956504;3503.334366470372;3523.7357198210125;3560.412531932233;5802.252791167546;5832.125181222814;5839.854003649911;5876.647401155923;5894.17481552583;5841.123831425289;5862.88274234515;5876.382979787125;5915.053591425372;5924.348321684622;5274;5293.497117773805;5357.4106848246665;5369.4362091980365;5376.946230537703;4683.414573178353;5026.798928042892;5210.270562121306;5371.838844834641;5418.539424148952;5322.654027488201;5326.973365133188;5352.678839269656;5365.704886231256;5450.91823622646;5299.49654782795;5401.108817045183;5411.026015317241;5413.53984911283;5418.349798024262;5247.501487358695;5344.091504444254;5358.062339090644;5381;5383.676979381211;5582.525485333752;5685.317761868561;5806.1000544915605;5834.066549352126;5838.474537291664;6211.565190436671;6252.218472690914;6271.466925311354;6279.937200627981;6299.937000630027;5309.124339232343;6256.906146407808;6260.15487909131;6262.154609127755;6281.560290779647;5852.912206316909;5944.108383742473;5955.285365756137;5982.132590774313;6025.367336429699;6307.022411526221;6318.189057896009;6360.204974378203;6386.552941294065;6409.743610255631;4878.609711223094;5643.915341269884;6234.9688251558455;6302.1492098566105;6302.968485157545;6039.54703397247;6211.565190436717;6227.314995350508;6267;6279.654618995999;5472.425395333512;6262.5929314594405;6262.812115636538;6273.811785646438;6276.340984196594;6060.515158787286;6193.071039344134;6211.472024877936;6259.593126446766;6274.341194174546;4956;5012.022655582126;5023.14606516893;5027.874303142451;5052.393712754493;4491.416115904912;4505.707129036602;4513.932291015637;4529.116822219636;4540.909181816345;5172.405173405032;5884.823455296262;5972.163897054415;5989.670568118795;6130.908036379458;5291.470852914677;6183.938160618336;6240.126382306481;6261.186045814106;6269.373062693694;5909.5863289569315;5977.880442391215;5984.730687119003;5999.670018148957;6001.219841420675;5432.538234250054;5443.836684899459;5534.889302213933;5539.861503462445;5541.806036788693;6477.481801455872;6497.220333559909;6498.447631951337;6500.902486462613;6565.967170164118;6160.476359509492;6218.595791273553;6219.720112595034;6244.781432649836;6246.937530624636;6360.268569114611;6425.261094974137;6470.38531339522;6526.282108967915;6534.607923524603;6156.538259630456;6194.969025154845;6196.504279657526;6205.6586887721605;6225.844353891189;4932.679375840559;6065.5754097212775;6206.255249370104;6214.40963108504;6244.65654389013;6093.786717464867;6174.598651087665;6223.19098517208;6274.466670333073;6296;6121.816345509642;6197.876042479215;6205.720742566505;6244.406781355764;6264.68676566179;5100.438951715234;5532.56284166633;6074.787382441594;6151.753929842936;6163.229596300463;5697.6296540724725;5793.783305505891;6158.7228574715145;6219.471344935731;6276.811695649138;6115.816525504242;6140.600860944024;6151;6164.845878853064;6171.876562468815 16:38:46 INFO - PROCESS | 1684 | |1;ext.html;523.4268476018758;537.0735481294766;542.4033563080612;563.332451045511;593.6141508019784;38124;38712.22575548488;39176.804115979416;39207.41188882162;39219.803900980456;40331.19337613246;40923.79538102313;41016;41042.794786026105;41073.7946310268;9403.576839042242;9556.569954352071;9593.856092158623;9613.279004074688;9645.75885602862;9495.857562136573;9544.761380965496;9643.903560964405;9661.758456038586;9763.951180244125;9649.903500965005;9672.274579406538;9742.07450292221;9745.074217949283;9762.365446246007;8484.74545763622;9655.855162172573;9669.468179250138;9720.659776907774;9722.319437639368;8487.83024339516;9609.855852162224;9650.71047868565;9724.319297649097;9759.902400976041;32334.191645208823;39064.60935390638;39132.82601521959;39460.01349966245;39498.40752388717;2635.3543381871564;2808.396194818124;2833.2916770807296;3214.324991751735;3289.342131573695;25328.240152795446;25397.238082857544;25617;26130.085447009264;26744.86627566869;2679.7052324244514;2695.514807334679;2729.5905614157837;2744.19046381316;2796.231036464968;307909;310625;311193;312733;313866;35211.64788352084;36131.4580281296;47295.5270447298;57935.392907318426;58032.70983645055;35155;35448.82275588657;35487.82256088703;35670.64329356725;35718.46422303667;15570.143642099567;15732.764008539882;15771;15825.683486330208;15844.76232856508;13064.804027939588;13096.410661520255;13378.598642040753;13454.856337211446;13457.596272111852;7812.843743125106;7976.361891048702;8046.476978996347;8214.8357032859;8291.58542072906;3407.2333724911696;3467.01190160803;3477.043812951408;3478.373892699288;3504.9299014019575;756.4100001998451;901.9233365164034;1016.8576399304103;1017.7481697512102;1067.524951396621;26024.8698756505;29787.55318670222;29995.250118747204;30485.695143048728;30649.080527584207;1040.573364920379;1093.185576745314;1136.3863513702672;1174.7944109780753;1183.6389901080254;13619.387127579283;14006;15438;15438.768418473732;15744.68510629781;629018;630003;633525;637263;652656;60038.699806501565;60298;61080;61289.387106128364;61315.6934215335;1473.7936688863567;1490.3442485306214;1491.0233796863072;1503.6015455904194;1512.4328376858678;29424.11727648174;29709.10872673737;29735.55396669095;30345;30377.848110760187;51379.97240055253;51771.22343164931;51875.2218716712;52361.7381913088;52481.7375913118;494387;577650;577947;579718;581758;26074;26406.603900941118;26475.470490590465;26775.732242678103;27220.72779272182;45116;46080.539194608966;47607.04785904332;47660;47925.28112078252;36844.81577592095;38106.61893381141;38123.80938095292;38435.42346864743;38512.844614661604;31885.043448696575;34745;37558.06104847401;37883.62116378801;38003.42994855024;31441.371172575964;35828.462573060904;37486;37711.434328485644;37885.62114378821;25224.524009100824;29298;30570.388592228475;31392.071671213962;31511.369772604878;24801;24946.251612451655;24950.251492455256;24967.716300784454;25138.62292065657 16:38:46 INFO - PROCESS | 1684 | |2;jquery.html;350.55654596934863;399.7281848343126;402.9516458025037;405.25739320920036;408.1367906876955;20248.29130980416;20358.880261585608;20858.95705214739;20923.163073477062;21532.354029379105;20472.69290960637;20779.584408311825;20850.270240541548;21038.684419733716;21130.89434552825;5346.973265133669;5999.580029397944;6006.549508786837;7161.641917904084;7576.128745194318;7269.309415605536;7493.587852668101;7511.323980841723;7599.278068583476;7806.024246969129;7705.768826935201;7774.727884524043;7784.571848548328;7794.06471223454;7794.181610930856;7182.102237220348;7587.734429294948;7593.582352970612;7597.354224890891;7733.381329493655;7359.300866417735;7386.667599958015;7480.663370148356;7493.700251989914;7494.775156745306;28299.43401131966;29011.564826527618;29410;29552.113436596937;29965.550516742267;2519.672442582471;2666.13350661034;2735.658042744657;2765.184270640166;3176.2059485128716;15157.924210378878;16294.348226070942;16586.75119873203;16739;16908.83091169085;1651.6696660667915;1876.634056358997;1916.549610841451;1931.33368987699;1971.8915459649713;125953;135325;136770;137451.999999999;143412;22424.551508970057;22528;22542.661860071785;22992.425189370064;23142.727150006576;32975.34049319048;34075.46660400288;35524.82237588847;36912.26175476529;37004.25991480155;10190.286679932482;10197.74505637365;11684.591039313584;11735.76528469443;11774.234674746114;7855.764327070197;9099.863502047474;9547.33168678186;9587.616495340108;9653.276004299705;8177.754667359989;10147.492625368703;10192.1336686381;10253.692389228336;10290.073893349485;3718.9070273242846;3942.329803933338;3969.285528604821;3996.5603783584365;4004;860.423516244118;920.615605581547;929.3587424676952;931.729798358482;1018.7758693087509;19645.31241406544;20303.28938487146;20413.591728165353;20748.792512074688;20992.265270715452;863.5121156546531;909.7179874239007;961.1493827962304;980.9117179453883;1014.7412409835592;10593.788124237471;10938.56245750161;10963.725906852393;11003.284786488852;11007.944960275147;528341;540123;544139;662787;669256;128339;130201;133446;135504;137891;1011.5903059261011;1031.1956673794452;1037.3412882819464;1052.4211683574156;1056.27645063132;18549.814501855348;18755.81244187595;18958.336458223897;19111.52221194481;19169.233230671176;50178.24732629087;50351.74824125856;50900.999999998516;52968.73515632397;54133.375998720105;58667.4133258662;69356.6532167336;71323.64338178276;73233.26766732264;74255;7962.960185199037;7990.800229994296;8069.233422824822;8150.7147249845975;8340.29107525867;12453.564125255572;12494.500219991098;12764.936175319064;12775;12825.102242843284;11107.000369966741;11168.441577921234;11224.887751122711;11242.94378528102;11445;8775;10765.730856728644;10868.891311086787;10949.890501094887;10960.506777194885;11127.55489780432;11225.775484490428;11641.301521908712;11687.474063667325;11709.946104850604;8227.917720822954;8253.215944485264;8373.665053397795;8427.578621069044;8586.22723954847;10830.837537437103;11237.438128093727;11316.886831131584;11411.31532108043;11437.241406846548 16:38:46 INFO - PROCESS | 1684 | |3;mootools.html;1415.7451658701432;1604.1979010494751;1831.1210618902926;1940.301491463073;1973.7335459712936;7941.324987376065;8751.91248087519;8792.856928599273;8953.194212520872;8996.96534898486;7021.789346319606;8678.262347700453;8791.340649451286;8793.516356600401;8809.119088091187;2458.4960083182996;2465.9630105548385;2486.27897909606;2489.0914816092177;2493.7007559092845;2441;2479.119912431088;2492.9376765580823;2495.7504249575077;2502.51201015802;2446.241665083821;2472.0235506974736;2475.059477398586;2505.235903049569;2507.5862482690336;2468.259522143359;2485.2544236729;2487.4776296977657;2494.837835540702;2498.3004758667603;2454.104251948044;2460.520198561281;2471.0980492120425;2497.126005897939;2499.212747984379;8932;8957.865632015524;8991.460512369278;8994.550272486349;9002.819943601091;4608.446986361624;5152.634551843765;5538.086215774392;5544.77820887164;5555.555555555546;3050.4051709916575;3346.2638219591895;3530.6645868642436;3619.3304238715923;3640.8179591020344;932.5523748600709;995.2585323933644;1038.3095241664284;1064.5528877871313;1129.2603344809163;11495.482703278372;11567.942160289145;11712.648620541397;11729.589464368792;11738.002269807077;3911.3546264865977;4604.871806407452;4671.579557839811;4692.483826779052;4727.64542659302;9178.21985131258;9212.815743685089;9246.075392460834;9265.768355791159;9272.443653380818;5332.68003919766;5337.839864803985;5376.220448035091;5377.919331210035;5403.189521571796;4061.700255918078;4493.483249426293;4834.057358814997;4976.701397916137;5013.097642424325;3301.7028467437567;3464.7055000325254;3898.200868821885;3949.5063117110362;3957.742746721454;1239.7148655809215;1250.8874201321742;1252.2549083295426;1253.8056601226824;1256.3278645924386;815.1603848036532;878.9252913502296;884.7699598104539;934.6868798952427;942.9245660347156;4990.30135780991;5756.42435756421;5790.131480277992;5850.268716410449;5876.823695289148;933.8645896344992;937.3344925103253;971.9319647624599;979.2068424576116;1006.0894890124449;3755.1550901047594;3756.9436458453147;3774.0564858785306;3843.1545060086737;3845.7115716321387;10506.947465262778;10758.139348852073;10779;10797.46012699362;10851.728706782395;10535.63125290611;10663.84004239937;10696.732581685521;10719.356838589709;10823.296485728402;8221.753347399588;8339.416240863202;8361.03848057469;8464;8489;5718.342390625131;5783.190353350618;5794.507466865363;5931.08068249422;5956.731947062306;9277.76805579839;9447.763805904908;9454.480003599592;9560;9562.521873906417;9444.669436569688;9710.514474276399;9842.704718858446;9861.457619830979;9936.602535898483;6798.694058767466;7246.818829529304;7464.104307483137;7475.551466912003;7583.393328533814;8167;8167.836643266983;8231.670733170846;8241.546714930497;8243.917560824315;7183.928160718535;7312.597807120446;7324.340809327186;7389.556626602421;7436.59098749574;7060.858782824417;7218.205997340184;7223;7229.783106506813;7305.41556675454;6910.481713871379;6919.238883722887;6960.3735663788475;6973.965130174317;6994.125734283215;4821.2045012572535;4844.467108617979;4850.4179498459;4935.605151587936;4947.579455746158;4903.26451032348;4932.482089380707;4961.7519124044375;4966.751662416792;5128.358955130609 16:38:46 INFO - PROCESS | 1684 | |4;prototype.html;287.87765199790084;328.7090924531789;330.3788876911406;337.38764143080317;339.1622691950882;5417.756200970956;6781.898271525931;6792.049113124161;6792.864142717142;6820.727170913157;6695.430888374494;6703.564268322556;6723.899141512881;6727.629980351078;6786.8303292417595;4786.664933454659;4827.44484384295;4970.627202959774;4975.950240497603;4987.576056035223;4913.82801601944;4970.850874473772;4974.925376119361;4981.676191047589;4991.40103187618;4915.262710593403;4929.827456039039;4931.975340123295;4940.407151141868;4952.950470495303;4933.33399991002;4941.110600091982;4958.801647934079;4960.627952903528;5011.32347133136;4277.016286254179;4281.207976524353;4289.828406863721;4299.226139294926;4307.892302692427;5434;6348.365163483661;6519.674016299214;6567.704453299565;6570.211574611078;5899.793507227227;5917.993941029992;5970.686448981217;5975.940240597582;5981.700914954235;7207.639618019078;7251.492395532315;7255.238199988978;7261.237570055121;7270.6001169935635;4306.923269182705;4540.636749060067;4812.446568644581;4816.036792641451;4830.7440065583205;7471.962640186819;7746.070471543451;7757.448510297907;7758.340541054017;7769.53382797034;4882.536159064884;4890.877728056827;4899.2896030075435;4908.558229759339;4914;4137.77242251673;4911.901761964741;4982.975085124551;4987.501249874984;4997;5925.555583331267;5930.28836539618;5930.584859059824;5945.524358051345;5950.583459157904;7377.704891804375;7379.077615298088;7403.666834992438;7416.925830741731;7417;1716.8369004944511;1743.8692098092695;1744.9617477600807;1744.9651006979789;1755.692753768111;990.2375171118199;1021.2340744441668;1057.460695045517;1066.461436974323;1068.770214403907;6777.2545020047755;6804.76183333581;6831.11195544586;6842.55523390978;6843.418309443654;5725.570582206351;7399.741009064657;7584.886226706604;7617.581033043125;7636.274553917369;6291.7797877075;6325.746970121236;6866;6970.233274339818;6975.337342952412;3013.819170849756;4036.616521430459;4039.7072936660575;4078;4090.427340172378;8160.061592916772;8188.877166842502;8203.507789532647;8207.138250483733;8208.0560735515;7722.343600793995;7971.880421793678;7973.521588704696;8024.398170137263;8049.51702897828;8163.469374490639;8200.220979006985;8202.179782021869;8204.179582041748;8239.588020599065;7747.72882949094;7762.262585054411;7764.301212890867;7764.650590723318;7781.5331080135375;7596.468247222641;7606.619669016416;7634.083909930844;7653.770386888402;7664.578448185403;7290.890636640561;7781.105172905189;8154.184581541798;8217.54803485814;8238.340932725487;4711.929321060118;4738.123447162286;4796.712197268175;4802.591779698625;4805.783739731791;7636.770896873103;7670.424718146273;7673.386129109769;7693.653785579774;7709.9614501927135;7396.927445520477;7402.4448166386655;7408.666610002455;7414.22150674193;7436.73971410998;7159.248278930637;7433.8141546461775;7462.843259294818;7467.850642987219;7479.252074792477;7199.532030418006;7254.818629534304;7258.49190556656;7290.416766658548;7303.890441643273;7433.814154645961;7444.627768611656;7451.441141914486;7485.7754267372065;7511.248875112664;5723.914141287801;7226.060612120391;7276.417886569167;7291.562506249642;7296.051513303237 16:38:46 INFO - PROCESS | 1684 | |5;yui.html;672.357898207212;677.6932593369139;712.8396110875054;745.4297462441236;761.9961900190501;14896.627584310385;14932.880033997466;15066.54800355991;15073.321700523475;15123;11521.654350369503;13842.861571384283;13855.653608659763;13897.652558686037;13911.026228164008;729.6680010595193;893.6246776353947;903.5527413930097;929.1962452478591;929.7071422501924;843.6878355008655;875.4003507597316;918.3158546882548;931.2131249094505;935.5836652689555;962.4465932089076;984.3257368702426;988.1107003696659;989.1789814454022;989.1839232633071;949.1552518258756;957.7414098193518;958.420155805738;984.050391372322;985.6599473181741;715.0668377767012;721.339973923859;728.5264578024273;729.3873146556917;732;14785.26073696311;14833.629159270997;14867.405303787835;15040.32318545668;15057.849421505754;12914.612561623166;12944.352782360844;13096.803547946789;13116.868831311756;13180.472781088745;9955.16943171537;10075.848862267072;10247.282690211689;10257.025582569644;10273.075423211947;3578.3737845877126;3590.5152804371596;3682.9263414731554;3714.572824125233;3805.4101614249835;66233.34416639623;79702.80445793318;80389.59805200995;80603.19396806075;81055.5947220266;9627.470489123165;9692.563834627459;9771.364861284135;9805.166560842408;9942.552585133686;22418.663720044213;22589.88705056464;22803.429914252276;22806.65790013151;22840.200592979167;7607.961960190274;7763.689452421952;7914.920850791418;7994.68021279154;8075.636596353178;4157.97921010399;4183.811728472226;4203.642690371353;4204.26425375558;4419.602235798793;3718.3121122591865;3748.775073495599;3781.149241420658;3789.052736815796;3789.829457674411;674.089978528982;713.714514194316;721.1706537481938;746.4998451037818;750.7747675697269;574.7844558290641;583.201014609987;601.5067644531442;609.3053918532876;613.7238242790762;7778.444311137795;8360.45657032291;8408.285295749807;8435.451695639764;8451.53516556583;545.7053191276746;581.8080033588906;593.1843714892024;593.8426317025992;604.3503234023442;3576.1059735066233;3870.1292209253256;3938.2911076006594;3954.5254569451276;4020.1758639478835;95073;95461;95689;96757.51621241849;97043.02956970481;73637.63181184167;74566;79958.60020699976;81018.5949070251;81643.5917820419;66835.33164668389;68714.65642671754;68747;69771.65114174396;70116;8406.243438090602;8427.5786210688;8544.829103418022;8559.443636163629;8643.092475290256;45924.770376147906;46542.30186547137;46713.06573868436;47423.76288118537;47929.52070479251;59222;61604.383956159865;61927.38072619216;63165.68417157885;63396.41508962313;8253.752387428387;9746.75633109178;10360.119389851947;11152.609658662232;11435.885641143483;11582.768344633228;12165.81751273714;12200.267983920638;12213.45039473208;12303;11257.605983790529;11264.774704506028;11352;11547.249428787438;11671.416429178676;11244.943775281072;11285.589301337333;11299.322040677585;11477.311361318347;11667.708307292385;10580;10793.460326983777;10840.45797710127;11015.228933974866;11422.657320280405;9321.906780932104;9413.717588472357;9543.236541076836;9708.75728106803;9802.950985245028;9397.624095036123;9693.757656058373;9706.805863882542;9716.222702183666;9796.755081123029 16:38:46 INFO - PROCESS | 1684 | __end_tp_report 16:38:46 INFO - PROCESS | 1684 | __start_cc_report 16:38:46 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,417 16:38:46 INFO - PROCESS | 1684 | __end_cc_report 16:38:46 INFO - PROCESS | 1684 | __startTimestamp1464910726040__endTimestamp 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | ------- Summary: start ------- 16:38:46 INFO - PROCESS | 1684 | Number of tests: 6 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5793.80 Median:6001.22 stddev:634.92 (10.6%) stddev-sans-first:609.62 16:38:46 INFO - PROCESS | 1684 | Values: 3447.8 3495.7 3503.3 3523.7 3560.4 5802.3 5832.1 5839.9 5876.6 5894.2 5841.1 5862.9 5876.4 5915.1 5924.3 5274.0 5293.5 5357.4 5369.4 5376.9 4683.4 5026.8 5210.3 5371.8 5418.5 5322.7 5327.0 5352.7 5365.7 5450.9 5299.5 5401.1 5411.0 5413.5 5418.3 5247.5 5344.1 5358.1 5381.0 5383.7 5582.5 5685.3 5806.1 5834.1 5838.5 6211.6 6252.2 6271.5 6279.9 6299.9 5309.1 6256.9 6260.2 6262.2 6281.6 5852.9 5944.1 5955.3 5982.1 6025.4 6307.0 6318.2 6360.2 6386.6 6409.7 4878.6 5643.9 6235.0 6302.1 6303.0 6039.5 6211.6 6227.3 6267.0 6279.7 5472.4 6262.6 6262.8 6273.8 6276.3 6060.5 6193.1 6211.5 6259.6 6274.3 4956.0 5012.0 5023.1 5027.9 5052.4 4491.4 4505.7 4513.9 4529.1 4540.9 5172.4 5884.8 5972.2 5989.7 6130.9 5291.5 6183.9 6240.1 6261.2 6269.4 5909.6 5977.9 5984.7 5999.7 6001.2 5432.5 5443.8 5534.9 5539.9 5541.8 6477.5 6497.2 6498.4 6500.9 6566.0 6160.5 6218.6 6219.7 6244.8 6246.9 6360.3 6425.3 6470.4 6526.3 6534.6 6156.5 6195.0 6196.5 6205.7 6225.8 4932.7 6065.6 6206.3 6214.4 6244.7 6093.8 6174.6 6223.2 6274.5 6296.0 6121.8 6197.9 6205.7 6244.4 6264.7 5100.4 5532.6 6074.8 6151.8 6163.2 5697.6 5793.8 6158.7 6219.5 6276.8 6115.8 6140.6 6151.0 6164.8 6171.9 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:62755.78 Median:37165.41 stddev:140263.16 (377.4%) stddev-sans-first:140578.81 16:38:46 INFO - PROCESS | 1684 | Values: 523.4 537.1 542.4 563.3 593.6 38124.0 38712.2 39176.8 39207.4 39219.8 40331.2 40923.8 41016.0 41042.8 41073.8 9403.6 9556.6 9593.9 9613.3 9645.8 9495.9 9544.8 9643.9 9661.8 9764.0 9649.9 9672.3 9742.1 9745.1 9762.4 8484.7 9655.9 9669.5 9720.7 9722.3 8487.8 9609.9 9650.7 9724.3 9759.9 32334.2 39064.6 39132.8 39460.0 39498.4 2635.4 2808.4 2833.3 3214.3 3289.3 25328.2 25397.2 25617.0 26130.1 26744.9 2679.7 2695.5 2729.6 2744.2 2796.2 307909.0 310625.0 311193.0 312733.0 313866.0 35211.6 36131.5 47295.5 57935.4 58032.7 35155.0 35448.8 35487.8 35670.6 35718.5 15570.1 15732.8 15771.0 15825.7 15844.8 13064.8 13096.4 13378.6 13454.9 13457.6 7812.8 7976.4 8046.5 8214.8 8291.6 3407.2 3467.0 3477.0 3478.4 3504.9 756.4 901.9 1016.9 1017.7 1067.5 26024.9 29787.6 29995.3 30485.7 30649.1 1040.6 1093.2 1136.4 1174.8 1183.6 13619.4 14006.0 15438.0 15438.8 15744.7 629018.0 630003.0 633525.0 637263.0 652656.0 60038.7 60298.0 61080.0 61289.4 61315.7 1473.8 1490.3 1491.0 1503.6 1512.4 29424.1 29709.1 29735.6 30345.0 30377.8 51380.0 51771.2 51875.2 52361.7 52481.7 494387.0 577650.0 577947.0 579718.0 581758.0 26074.0 26406.6 26475.5 26775.7 27220.7 45116.0 46080.5 47607.0 47660.0 47925.3 36844.8 38106.6 38123.8 38435.4 38512.8 31885.0 34745.0 37558.1 37883.6 38003.4 31441.4 35828.5 37486.0 37711.4 37885.6 25224.5 29298.0 30570.4 31392.1 31511.4 24801.0 24946.3 24950.3 24967.7 25138.6 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:36849.13 Median:2592.90 stddev:99116.68 (3822.6%) stddev-sans-first:99356.84 16:38:46 INFO - PROCESS | 1684 | Values: 350.6 399.7 403.0 405.3 408.1 20248.3 20358.9 20859.0 20923.2 21532.4 20472.7 20779.6 20850.3 21038.7 21130.9 5347.0 5999.6 6006.5 7161.6 7576.1 7269.3 7493.6 7511.3 7599.3 7806.0 7705.8 7774.7 7784.6 7794.1 7794.2 7182.1 7587.7 7593.6 7597.4 7733.4 7359.3 7386.7 7480.7 7493.7 7494.8 28299.4 29011.6 29410.0 29552.1 29965.6 2519.7 2666.1 2735.7 2765.2 3176.2 15157.9 16294.3 16586.8 16739.0 16908.8 1651.7 1876.6 1916.5 1931.3 1971.9 125953.0 135325.0 136770.0 137452.0 143412.0 22424.6 22528.0 22542.7 22992.4 23142.7 32975.3 34075.5 35524.8 36912.3 37004.3 10190.3 10197.7 11684.6 11735.8 11774.2 7855.8 9099.9 9547.3 9587.6 9653.3 8177.8 10147.5 10192.1 10253.7 10290.1 3718.9 3942.3 3969.3 3996.6 4004.0 860.4 920.6 929.4 931.7 1018.8 19645.3 20303.3 20413.6 20748.8 20992.3 863.5 909.7 961.1 980.9 1014.7 10593.8 10938.6 10963.7 11003.3 11007.9 528341.0 540123.0 544139.0 662787.0 669256.0 128339.0 130201.0 133446.0 135504.0 137891.0 1011.6 1031.2 1037.3 1052.4 1056.3 18549.8 18755.8 18958.3 19111.5 19169.2 50178.2 50351.7 50901.0 52968.7 54133.4 58667.4 69356.7 71323.6 73233.3 74255.0 7963.0 7990.8 8069.2 8150.7 8340.3 12453.6 12494.5 12764.9 12775.0 12825.1 11107.0 11168.4 11224.9 11242.9 11445.0 8775.0 10765.7 10868.9 10949.9 10960.5 11127.6 11225.8 11641.3 11687.5 11709.9 8227.9 8253.2 8373.7 8427.6 8586.2 10830.8 11237.4 11316.9 11411.3 11437.2 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:5650.97 Median:5140.50 stddev:3130.81 (60.9%) stddev-sans-first:3123.41 16:38:46 INFO - PROCESS | 1684 | Values: 1415.7 1604.2 1831.1 1940.3 1973.7 7941.3 8751.9 8792.9 8953.2 8997.0 7021.8 8678.3 8791.3 8793.5 8809.1 2458.5 2466.0 2486.3 2489.1 2493.7 2441.0 2479.1 2492.9 2495.8 2502.5 2446.2 2472.0 2475.1 2505.2 2507.6 2468.3 2485.3 2487.5 2494.8 2498.3 2454.1 2460.5 2471.1 2497.1 2499.2 8932.0 8957.9 8991.5 8994.6 9002.8 4608.4 5152.6 5538.1 5544.8 5555.6 3050.4 3346.3 3530.7 3619.3 3640.8 932.6 995.3 1038.3 1064.6 1129.3 11495.5 11567.9 11712.6 11729.6 11738.0 3911.4 4604.9 4671.6 4692.5 4727.6 9178.2 9212.8 9246.1 9265.8 9272.4 5332.7 5337.8 5376.2 5377.9 5403.2 4061.7 4493.5 4834.1 4976.7 5013.1 3301.7 3464.7 3898.2 3949.5 3957.7 1239.7 1250.9 1252.3 1253.8 1256.3 815.2 878.9 884.8 934.7 942.9 4990.3 5756.4 5790.1 5850.3 5876.8 933.9 937.3 971.9 979.2 1006.1 3755.2 3756.9 3774.1 3843.2 3845.7 10506.9 10758.1 10779.0 10797.5 10851.7 10535.6 10663.8 10696.7 10719.4 10823.3 8221.8 8339.4 8361.0 8464.0 8489.0 5718.3 5783.2 5794.5 5931.1 5956.7 9277.8 9447.8 9454.5 9560.0 9562.5 9444.7 9710.5 9842.7 9861.5 9936.6 6798.7 7246.8 7464.1 7475.6 7583.4 8167.0 8167.8 8231.7 8241.5 8243.9 7183.9 7312.6 7324.3 7389.6 7436.6 7060.9 7218.2 7223.0 7229.8 7305.4 6910.5 6919.2 6960.4 6974.0 6994.1 4821.2 4844.5 4850.4 4935.6 4947.6 4903.3 4932.5 4961.8 4966.8 5128.4 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:6013.32 Median:6789.44 stddev:1971.92 (29.0%) stddev-sans-first:1930.05 16:38:46 INFO - PROCESS | 1684 | Values: 287.9 328.7 330.4 337.4 339.2 5417.8 6781.9 6792.0 6792.9 6820.7 6695.4 6703.6 6723.9 6727.6 6786.8 4786.7 4827.4 4970.6 4976.0 4987.6 4913.8 4970.9 4974.9 4981.7 4991.4 4915.3 4929.8 4932.0 4940.4 4953.0 4933.3 4941.1 4958.8 4960.6 5011.3 4277.0 4281.2 4289.8 4299.2 4307.9 5434.0 6348.4 6519.7 6567.7 6570.2 5899.8 5918.0 5970.7 5975.9 5981.7 7207.6 7251.5 7255.2 7261.2 7270.6 4306.9 4540.6 4812.4 4816.0 4830.7 7472.0 7746.1 7757.4 7758.3 7769.5 4882.5 4890.9 4899.3 4908.6 4914.0 4137.8 4911.9 4983.0 4987.5 4997.0 5925.6 5930.3 5930.6 5945.5 5950.6 7377.7 7379.1 7403.7 7416.9 7417.0 1716.8 1743.9 1745.0 1745.0 1755.7 990.2 1021.2 1057.5 1066.5 1068.8 6777.3 6804.8 6831.1 6842.6 6843.4 5725.6 7399.7 7584.9 7617.6 7636.3 6291.8 6325.7 6866.0 6970.2 6975.3 3013.8 4036.6 4039.7 4078.0 4090.4 8160.1 8188.9 8203.5 8207.1 8208.1 7722.3 7971.9 7973.5 8024.4 8049.5 8163.5 8200.2 8202.2 8204.2 8239.6 7747.7 7762.3 7764.3 7764.7 7781.5 7596.5 7606.6 7634.1 7653.8 7664.6 7290.9 7781.1 8154.2 8217.5 8238.3 4711.9 4738.1 4796.7 4802.6 4805.8 7636.8 7670.4 7673.4 7693.7 7710.0 7396.9 7402.4 7408.7 7414.2 7436.7 7159.2 7433.8 7462.8 7467.9 7479.3 7199.5 7254.8 7258.5 7290.4 7303.9 7433.8 7444.6 7451.4 7485.8 7511.2 5723.9 7226.1 7276.4 7291.6 7296.1 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:18081.16 Median:63281.05 stddev:25341.86 (40.0%) stddev-sans-first:25379.23 16:38:46 INFO - PROCESS | 1684 | Values: 672.4 677.7 712.8 745.4 762.0 14896.6 14932.9 15066.5 15073.3 15123.0 11521.7 13842.9 13855.7 13897.7 13911.0 729.7 893.6 903.6 929.2 929.7 843.7 875.4 918.3 931.2 935.6 962.4 984.3 988.1 989.2 989.2 949.2 957.7 958.4 984.1 985.7 715.1 721.3 728.5 729.4 732.0 14785.3 14833.6 14867.4 15040.3 15057.8 12914.6 12944.4 13096.8 13116.9 13180.5 9955.2 10075.8 10247.3 10257.0 10273.1 3578.4 3590.5 3682.9 3714.6 3805.4 66233.3 79702.8 80389.6 80603.2 81055.6 9627.5 9692.6 9771.4 9805.2 9942.6 22418.7 22589.9 22803.4 22806.7 22840.2 7608.0 7763.7 7914.9 7994.7 8075.6 4158.0 4183.8 4203.6 4204.3 4419.6 3718.3 3748.8 3781.1 3789.1 3789.8 674.1 713.7 721.2 746.5 750.8 574.8 583.2 601.5 609.3 613.7 7778.4 8360.5 8408.3 8435.5 8451.5 545.7 581.8 593.2 593.8 604.4 3576.1 3870.1 3938.3 3954.5 4020.2 95073.0 95461.0 95689.0 96757.5 97043.0 73637.6 74566.0 79958.6 81018.6 81643.6 66835.3 68714.7 68747.0 69771.7 70116.0 8406.2 8427.6 8544.8 8559.4 8643.1 45924.8 46542.3 46713.1 47423.8 47929.5 59222.0 61604.4 61927.4 63165.7 63396.4 8253.8 9746.8 10360.1 11152.6 11435.9 11582.8 12165.8 12200.3 12213.5 12303.0 11257.6 11264.8 11352.0 11547.2 11671.4 11244.9 11285.6 11299.3 11477.3 11667.7 10580.0 10793.5 10840.5 11015.2 11422.7 9321.9 9413.7 9543.2 9708.8 9803.0 9397.6 9693.8 9706.8 9716.2 9796.8 16:38:46 INFO - PROCESS | 1684 | -------- Summary: end -------- 16:38:46 INFO - PROCESS | 1684 | 16:38:46 INFO - TEST-INFO | 1684: exit 0 16:38:46 INFO - TEST-OK | dromaeo_css | took 1110655ms 16:38:46 INFO - TEST-START | kraken 16:38:46 INFO - operating with platform_type : mac_ 16:38:46 INFO - Initialising browser for kraken test... 16:38:46 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmp8TFnvP/profile http://localhost:49270/getInfo.html) 16:38:49 INFO - PROCESS | 1695 | __metrics Screen width/height:1600/1200 16:38:49 INFO - PROCESS | 1695 | colorDepth:24 16:38:49 INFO - PROCESS | 1695 | Browser inner width/height: 1024/689 16:38:49 INFO - PROCESS | 1695 | __metrics 16:38:49 ERROR - PROCESS | 1695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 16:38:50 INFO - TEST-INFO | 1695: exit 0 16:38:50 INFO - Browser initialized. 16:38:50 INFO - Running cycle 1/1 for kraken test... 16:38:50 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/T/tmp8TFnvP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:02 INFO - PROCESS | 1698 | RSS: Main: 221335552 16:39:02 INFO - PROCESS | 1698 | 16:39:04 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:39:05 INFO - PROCESS | 1698 | RSS: Main: 232935424 16:39:05 INFO - PROCESS | 1698 | 16:39:08 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:39:09 INFO - PROCESS | 1698 | RSS: Main: 241856512 16:39:09 INFO - PROCESS | 1698 | 16:39:12 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:39:13 INFO - PROCESS | 1698 | RSS: Main: 244031488 16:39:13 INFO - PROCESS | 1698 | 16:39:15 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:39:15 INFO - PROCESS | 1698 | RSS: Main: 246603776 16:39:15 INFO - PROCESS | 1698 | 16:39:17 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:39:18 INFO - PROCESS | 1698 | RSS: Main: 247001088 16:39:18 INFO - PROCESS | 1698 | 16:39:21 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:22 INFO - PROCESS | 1698 | RSS: Main: 247472128 16:39:22 INFO - PROCESS | 1698 | 16:39:25 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:25 INFO - PROCESS | 1698 | RSS: Main: 247648256 16:39:25 INFO - PROCESS | 1698 | 16:39:28 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:39:29 INFO - PROCESS | 1698 | RSS: Main: 248176640 16:39:29 INFO - PROCESS | 1698 | 16:39:30 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:31 INFO - PROCESS | 1698 | RSS: Main: 247152640 16:39:31 INFO - PROCESS | 1698 | 16:39:33 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:33 INFO - PROCESS | 1698 | RSS: Main: 247242752 16:39:33 INFO - PROCESS | 1698 | 16:39:36 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:36 INFO - PROCESS | 1698 | RSS: Main: 247676928 16:39:36 INFO - PROCESS | 1698 | 16:39:39 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:40 INFO - PROCESS | 1698 | RSS: Main: 247926784 16:39:40 INFO - PROCESS | 1698 | 16:39:43 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:43 INFO - PROCESS | 1698 | RSS: Main: 247623680 16:39:43 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:39:45 INFO - PROCESS | 1698 | RSS: Main: 249556992 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | __start_tp_report 16:39:45 INFO - PROCESS | 1698 | _x_x_mozilla_page_load 16:39:45 INFO - PROCESS | 1698 | _x_x_mozilla_page_load_details 16:39:45 INFO - PROCESS | 1698 | |i|pagename|runs| 16:39:45 INFO - PROCESS | 1698 | |0;ai-astar;111;120;108;117;118;115;106;116;117;117 16:39:45 INFO - PROCESS | 1698 | |1;audio-beat-detection;188;116;197;148;150;130;122;138;149;139 16:39:45 INFO - PROCESS | 1698 | |2;audio-dft;198;199;201;198;203;272;191;274;187;272 16:39:45 INFO - PROCESS | 1698 | |3;audio-fft;71;85;73;141;58;57;50;61;156;80 16:39:45 INFO - PROCESS | 1698 | |4;audio-oscillator;76;89;148;77;80;80;119;81;88;157 16:39:45 INFO - PROCESS | 1698 | |5;imaging-gaussian-blur;93;117;90;97;117;86;78;129;131;88 16:39:45 INFO - PROCESS | 1698 | |6;imaging-darkroom;105;92;148;147;94;94;96;95;96;95 16:39:45 INFO - PROCESS | 1698 | |7;imaging-desaturate;92;102;90;89;93;92;92;91;92;92 16:39:45 INFO - PROCESS | 1698 | |8;json-parse-financial;62;65;66;66;66;65;65;82;65;61 16:39:45 INFO - PROCESS | 1698 | |9;json-stringify-tinderbox;65;64;71;68;68;79;74;70;69;69 16:39:45 INFO - PROCESS | 1698 | |10;stanford-crypto-aes;69;98;70;83;99;94;104;105;104;102 16:39:45 INFO - PROCESS | 1698 | |11;stanford-crypto-ccm;141;154;146;146;158;116;150;143;169;144 16:39:45 INFO - PROCESS | 1698 | |12;stanford-crypto-pbkdf2;171;164;168;211;190;214;185;177;179;213 16:39:45 INFO - PROCESS | 1698 | |13;stanford-crypto-sha256-iterative;67;69;69;69;72;83;96;94;77;65 16:39:45 INFO - PROCESS | 1698 | __end_tp_report 16:39:45 INFO - PROCESS | 1698 | __start_cc_report 16:39:45 INFO - PROCESS | 1698 | _x_x_mozilla_cycle_collect,1089 16:39:45 INFO - PROCESS | 1698 | __end_cc_report 16:39:45 INFO - PROCESS | 1698 | __startTimestamp1464910785932__endTimestamp 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | ------- Summary: start ------- 16:39:45 INFO - PROCESS | 1698 | Number of tests: 14 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#0] ai-astar Cycles:10 Average:114.50 Median:117.00 stddev:4.60 (3.9%) stddev-sans-first:4.70 16:39:45 INFO - PROCESS | 1698 | Values: 111.0 120.0 108.0 117.0 118.0 115.0 106.0 116.0 117.0 117.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:148.50 stddev:26.27 (17.7%) stddev-sans-first:23.47 16:39:45 INFO - PROCESS | 1698 | Values: 188.0 116.0 197.0 148.0 150.0 130.0 122.0 138.0 149.0 139.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#2] audio-dft Cycles:10 Average:219.50 Median:202.00 stddev:36.98 (18.3%) stddev-sans-first:38.40 16:39:45 INFO - PROCESS | 1698 | Values: 198.0 199.0 201.0 198.0 203.0 272.0 191.0 274.0 187.0 272.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#3] audio-fft Cycles:10 Average:83.20 Median:66.00 stddev:36.25 (54.9%) stddev-sans-first:38.17 16:39:45 INFO - PROCESS | 1698 | Values: 71.0 85.0 73.0 141.0 58.0 57.0 50.0 61.0 156.0 80.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:80.00 stddev:30.63 (38.3%) stddev-sans-first:31.28 16:39:45 INFO - PROCESS | 1698 | Values: 76.0 89.0 148.0 77.0 80.0 80.0 119.0 81.0 88.0 157.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:87.00 stddev:19.13 (22.0%) stddev-sans-first:19.97 16:39:45 INFO - PROCESS | 1698 | Values: 93.0 117.0 90.0 97.0 117.0 86.0 78.0 129.0 131.0 88.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:94.50 stddev:22.04 (23.3%) stddev-sans-first:23.37 16:39:45 INFO - PROCESS | 1698 | Values: 105.0 92.0 148.0 147.0 94.0 94.0 96.0 95.0 96.0 95.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#7] imaging-desaturate Cycles:10 Average:92.50 Median:92.00 stddev:3.54 (3.8%) stddev-sans-first:3.75 16:39:45 INFO - PROCESS | 1698 | Values: 92.0 102.0 90.0 89.0 93.0 92.0 92.0 91.0 92.0 92.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:5.77 (8.8%) stddev-sans-first:5.91 16:39:45 INFO - PROCESS | 1698 | Values: 62.0 65.0 66.0 66.0 66.0 65.0 65.0 82.0 65.0 61.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:4.32 (6.2%) stddev-sans-first:4.24 16:39:45 INFO - PROCESS | 1698 | Values: 65.0 64.0 71.0 68.0 68.0 79.0 74.0 70.0 69.0 69.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:76.50 stddev:13.88 (18.1%) stddev-sans-first:11.75 16:39:45 INFO - PROCESS | 1698 | Values: 69.0 98.0 70.0 83.0 99.0 94.0 104.0 105.0 104.0 102.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:148.00 stddev:13.69 (9.2%) stddev-sans-first:14.36 16:39:45 INFO - PROCESS | 1698 | Values: 141.0 154.0 146.0 146.0 158.0 116.0 150.0 143.0 169.0 144.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:187.50 stddev:19.16 (10.2%) stddev-sans-first:19.40 16:39:45 INFO - PROCESS | 1698 | Values: 171.0 164.0 168.0 211.0 190.0 214.0 185.0 177.0 179.0 213.0 16:39:45 INFO - PROCESS | 1698 | 16:39:45 INFO - PROCESS | 1698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:74.50 stddev:11.25 (15.1%) stddev-sans-first:11.44 16:39:45 INFO - PROCESS | 1698 | Values: 67.0 69.0 69.0 69.0 72.0 83.0 96.0 94.0 77.0 65.0 16:39:45 INFO - PROCESS | 1698 | -------- Summary: end -------- 16:39:45 INFO - PROCESS | 1698 | 16:39:46 INFO - TEST-INFO | 1698: exit 0 16:39:46 INFO - TEST-OK | kraken | took 60118ms 16:39:46 INFO - SUITE-END | took 1170s 16:39:47 INFO - Completed test suite (00:19:31) 16:39:47 INFO - javascript benchmark 16:39:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3447.8103704296263, 3495.650434956504, 3503.334366470372, 3523.7357198210125, 3560.412531932233, 5802.252791167546, 5832.125181222814, 5839.854003649911, 5876.647401155923, 5894.17481552583, 5841.123831425289, 5862.88274234515, 5876.382979787125, 5915.053591425372, 5924.348321684622, 5274.0, 5293.497117773805, 5357.4106848246665, 5369.4362091980365, 5376.946230537703, 4683.414573178353, 5026.798928042892, 5210.270562121306, 5371.838844834641, 5418.539424148952, 5322.654027488201, 5326.973365133188, 5352.678839269656, 5365.704886231256, 5450.91823622646, 5299.49654782795, 5401.108817045183, 5411.026015317241, 5413.53984911283, 5418.349798024262, 5247.501487358695, 5344.091504444254, 5358.062339090644, 5381.0, 5383.676979381211, 5582.525485333752, 5685.317761868561, 5806.1000544915605, 5834.066549352126, 5838.474537291664, 6211.565190436671, 6252.218472690914, 6271.466925311354, 6279.937200627981, 6299.937000630027, 5309.124339232343, 6256.906146407808, 6260.15487909131, 6262.154609127755, 6281.560290779647, 5852.912206316909, 5944.108383742473, 5955.285365756137, 5982.132590774313, 6025.367336429699, 6307.022411526221, 6318.189057896009, 6360.204974378203, 6386.552941294065, 6409.743610255631, 4878.609711223094, 5643.915341269884, 6234.9688251558455, 6302.1492098566105, 6302.968485157545, 6039.54703397247, 6211.565190436717, 6227.314995350508, 6267.0, 6279.654618995999, 5472.425395333512, 6262.5929314594405, 6262.812115636538, 6273.811785646438, 6276.340984196594, 6060.515158787286, 6193.071039344134, 6211.472024877936, 6259.593126446766, 6274.341194174546, 4956.0, 5012.022655582126, 5023.14606516893, 5027.874303142451, 5052.393712754493, 4491.416115904912, 4505.707129036602, 4513.932291015637, 4529.116822219636, 4540.909181816345, 5172.405173405032, 5884.823455296262, 5972.163897054415, 5989.670568118795, 6130.908036379458, 5291.470852914677, 6183.938160618336, 6240.126382306481, 6261.186045814106, 6269.373062693694, 5909.5863289569315, 5977.880442391215, 5984.730687119003, 5999.670018148957, 6001.219841420675, 5432.538234250054, 5443.836684899459, 5534.889302213933, 5539.861503462445, 5541.806036788693, 6477.481801455872, 6497.220333559909, 6498.447631951337, 6500.902486462613, 6565.967170164118, 6160.476359509492, 6218.595791273553, 6219.720112595034, 6244.781432649836, 6246.937530624636, 6360.268569114611, 6425.261094974137, 6470.38531339522, 6526.282108967915, 6534.607923524603, 6156.538259630456, 6194.969025154845, 6196.504279657526, 6205.6586887721605, 6225.844353891189, 4932.679375840559, 6065.5754097212775, 6206.255249370104, 6214.40963108504, 6244.65654389013, 6093.786717464867, 6174.598651087665, 6223.19098517208, 6274.466670333073, 6296.0, 6121.816345509642, 6197.876042479215, 6205.720742566505, 6244.406781355764, 6264.68676566179, 5100.438951715234, 5532.56284166633, 6074.787382441594, 6151.753929842936, 6163.229596300463, 5697.6296540724725, 5793.783305505891, 6158.7228574715145, 6219.471344935731, 6276.811695649138, 6115.816525504242, 6140.600860944024, 6151.0, 6164.845878853064, 6171.876562468815], "value": 5757.231207779276, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.4268476018758, 537.0735481294766, 542.4033563080612, 563.332451045511, 593.6141508019784, 38124.0, 38712.22575548488, 39176.804115979416, 39207.41188882162, 39219.803900980456, 40331.19337613246, 40923.79538102313, 41016.0, 41042.794786026105, 41073.7946310268, 9403.576839042242, 9556.569954352071, 9593.856092158623, 9613.279004074688, 9645.75885602862, 9495.857562136573, 9544.761380965496, 9643.903560964405, 9661.758456038586, 9763.951180244125, 9649.903500965005, 9672.274579406538, 9742.07450292221, 9745.074217949283, 9762.365446246007, 8484.74545763622, 9655.855162172573, 9669.468179250138, 9720.659776907774, 9722.319437639368, 8487.83024339516, 9609.855852162224, 9650.71047868565, 9724.319297649097, 9759.902400976041, 32334.191645208823, 39064.60935390638, 39132.82601521959, 39460.01349966245, 39498.40752388717, 2635.3543381871564, 2808.396194818124, 2833.2916770807296, 3214.324991751735, 3289.342131573695, 25328.240152795446, 25397.238082857544, 25617.0, 26130.085447009264, 26744.86627566869, 2679.7052324244514, 2695.514807334679, 2729.5905614157837, 2744.19046381316, 2796.231036464968, 307909.0, 310625.0, 311193.0, 312733.0, 313866.0, 35211.64788352084, 36131.4580281296, 47295.5270447298, 57935.392907318426, 58032.70983645055, 35155.0, 35448.82275588657, 35487.82256088703, 35670.64329356725, 35718.46422303667, 15570.143642099567, 15732.764008539882, 15771.0, 15825.683486330208, 15844.76232856508, 13064.804027939588, 13096.410661520255, 13378.598642040753, 13454.856337211446, 13457.596272111852, 7812.843743125106, 7976.361891048702, 8046.476978996347, 8214.8357032859, 8291.58542072906, 3407.2333724911696, 3467.01190160803, 3477.043812951408, 3478.373892699288, 3504.9299014019575, 756.4100001998451, 901.9233365164034, 1016.8576399304103, 1017.7481697512102, 1067.524951396621, 26024.8698756505, 29787.55318670222, 29995.250118747204, 30485.695143048728, 30649.080527584207, 1040.573364920379, 1093.185576745314, 1136.3863513702672, 1174.7944109780753, 1183.6389901080254, 13619.387127579283, 14006.0, 15438.0, 15438.768418473732, 15744.68510629781, 629018.0, 630003.0, 633525.0, 637263.0, 652656.0, 60038.699806501565, 60298.0, 61080.0, 61289.387106128364, 61315.6934215335, 1473.7936688863567, 1490.3442485306214, 1491.0233796863072, 1503.6015455904194, 1512.4328376858678, 29424.11727648174, 29709.10872673737, 29735.55396669095, 30345.0, 30377.848110760187, 51379.97240055253, 51771.22343164931, 51875.2218716712, 52361.7381913088, 52481.7375913118, 494387.0, 577650.0, 577947.0, 579718.0, 581758.0, 26074.0, 26406.603900941118, 26475.470490590465, 26775.732242678103, 27220.72779272182, 45116.0, 46080.539194608966, 47607.04785904332, 47660.0, 47925.28112078252, 36844.81577592095, 38106.61893381141, 38123.80938095292, 38435.42346864743, 38512.844614661604, 31885.043448696575, 34745.0, 37558.06104847401, 37883.62116378801, 38003.42994855024, 31441.371172575964, 35828.462573060904, 37486.0, 37711.434328485644, 37885.62114378821, 25224.524009100824, 29298.0, 30570.388592228475, 31392.071671213962, 31511.369772604878, 24801.0, 24946.251612451655, 24950.251492455256, 24967.716300784454, 25138.62292065657], "value": 18079.503086296896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.55654596934863, 399.7281848343126, 402.9516458025037, 405.25739320920036, 408.1367906876955, 20248.29130980416, 20358.880261585608, 20858.95705214739, 20923.163073477062, 21532.354029379105, 20472.69290960637, 20779.584408311825, 20850.270240541548, 21038.684419733716, 21130.89434552825, 5346.973265133669, 5999.580029397944, 6006.549508786837, 7161.641917904084, 7576.128745194318, 7269.309415605536, 7493.587852668101, 7511.323980841723, 7599.278068583476, 7806.024246969129, 7705.768826935201, 7774.727884524043, 7784.571848548328, 7794.06471223454, 7794.181610930856, 7182.102237220348, 7587.734429294948, 7593.582352970612, 7597.354224890891, 7733.381329493655, 7359.300866417735, 7386.667599958015, 7480.663370148356, 7493.700251989914, 7494.775156745306, 28299.43401131966, 29011.564826527618, 29410.0, 29552.113436596937, 29965.550516742267, 2519.672442582471, 2666.13350661034, 2735.658042744657, 2765.184270640166, 3176.2059485128716, 15157.924210378878, 16294.348226070942, 16586.75119873203, 16739.0, 16908.83091169085, 1651.6696660667915, 1876.634056358997, 1916.549610841451, 1931.33368987699, 1971.8915459649713, 125953.0, 135325.0, 136770.0, 137451.999999999, 143412.0, 22424.551508970057, 22528.0, 22542.661860071785, 22992.425189370064, 23142.727150006576, 32975.34049319048, 34075.46660400288, 35524.82237588847, 36912.26175476529, 37004.25991480155, 10190.286679932482, 10197.74505637365, 11684.591039313584, 11735.76528469443, 11774.234674746114, 7855.764327070197, 9099.863502047474, 9547.33168678186, 9587.616495340108, 9653.276004299705, 8177.754667359989, 10147.492625368703, 10192.1336686381, 10253.692389228336, 10290.073893349485, 3718.9070273242846, 3942.329803933338, 3969.285528604821, 3996.5603783584365, 4004.0, 860.423516244118, 920.615605581547, 929.3587424676952, 931.729798358482, 1018.7758693087509, 19645.31241406544, 20303.28938487146, 20413.591728165353, 20748.792512074688, 20992.265270715452, 863.5121156546531, 909.7179874239007, 961.1493827962304, 980.9117179453883, 1014.7412409835592, 10593.788124237471, 10938.56245750161, 10963.725906852393, 11003.284786488852, 11007.944960275147, 528341.0, 540123.0, 544139.0, 662787.0, 669256.0, 128339.0, 130201.0, 133446.0, 135504.0, 137891.0, 1011.5903059261011, 1031.1956673794452, 1037.3412882819464, 1052.4211683574156, 1056.27645063132, 18549.814501855348, 18755.81244187595, 18958.336458223897, 19111.52221194481, 19169.233230671176, 50178.24732629087, 50351.74824125856, 50900.999999998516, 52968.73515632397, 54133.375998720105, 58667.4133258662, 69356.6532167336, 71323.64338178276, 73233.26766732264, 74255.0, 7962.960185199037, 7990.800229994296, 8069.233422824822, 8150.7147249845975, 8340.29107525867, 12453.564125255572, 12494.500219991098, 12764.936175319064, 12775.0, 12825.102242843284, 11107.000369966741, 11168.441577921234, 11224.887751122711, 11242.94378528102, 11445.0, 8775.0, 10765.730856728644, 10868.891311086787, 10949.890501094887, 10960.506777194885, 11127.55489780432, 11225.775484490428, 11641.301521908712, 11687.474063667325, 11709.946104850604, 8227.917720822954, 8253.215944485264, 8373.665053397795, 8427.578621069044, 8586.22723954847, 10830.837537437103, 11237.438128093727, 11316.886831131584, 11411.31532108043, 11437.241406846548], "value": 11171.690204883045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.7451658701432, 1604.1979010494751, 1831.1210618902926, 1940.301491463073, 1973.7335459712936, 7941.324987376065, 8751.91248087519, 8792.856928599273, 8953.194212520872, 8996.96534898486, 7021.789346319606, 8678.262347700453, 8791.340649451286, 8793.516356600401, 8809.119088091187, 2458.4960083182996, 2465.9630105548385, 2486.27897909606, 2489.0914816092177, 2493.7007559092845, 2441.0, 2479.119912431088, 2492.9376765580823, 2495.7504249575077, 2502.51201015802, 2446.241665083821, 2472.0235506974736, 2475.059477398586, 2505.235903049569, 2507.5862482690336, 2468.259522143359, 2485.2544236729, 2487.4776296977657, 2494.837835540702, 2498.3004758667603, 2454.104251948044, 2460.520198561281, 2471.0980492120425, 2497.126005897939, 2499.212747984379, 8932.0, 8957.865632015524, 8991.460512369278, 8994.550272486349, 9002.819943601091, 4608.446986361624, 5152.634551843765, 5538.086215774392, 5544.77820887164, 5555.555555555546, 3050.4051709916575, 3346.2638219591895, 3530.6645868642436, 3619.3304238715923, 3640.8179591020344, 932.5523748600709, 995.2585323933644, 1038.3095241664284, 1064.5528877871313, 1129.2603344809163, 11495.482703278372, 11567.942160289145, 11712.648620541397, 11729.589464368792, 11738.002269807077, 3911.3546264865977, 4604.871806407452, 4671.579557839811, 4692.483826779052, 4727.64542659302, 9178.21985131258, 9212.815743685089, 9246.075392460834, 9265.768355791159, 9272.443653380818, 5332.68003919766, 5337.839864803985, 5376.220448035091, 5377.919331210035, 5403.189521571796, 4061.700255918078, 4493.483249426293, 4834.057358814997, 4976.701397916137, 5013.097642424325, 3301.7028467437567, 3464.7055000325254, 3898.200868821885, 3949.5063117110362, 3957.742746721454, 1239.7148655809215, 1250.8874201321742, 1252.2549083295426, 1253.8056601226824, 1256.3278645924386, 815.1603848036532, 878.9252913502296, 884.7699598104539, 934.6868798952427, 942.9245660347156, 4990.30135780991, 5756.42435756421, 5790.131480277992, 5850.268716410449, 5876.823695289148, 933.8645896344992, 937.3344925103253, 971.9319647624599, 979.2068424576116, 1006.0894890124449, 3755.1550901047594, 3756.9436458453147, 3774.0564858785306, 3843.1545060086737, 3845.7115716321387, 10506.947465262778, 10758.139348852073, 10779.0, 10797.46012699362, 10851.728706782395, 10535.63125290611, 10663.84004239937, 10696.732581685521, 10719.356838589709, 10823.296485728402, 8221.753347399588, 8339.416240863202, 8361.03848057469, 8464.0, 8489.0, 5718.342390625131, 5783.190353350618, 5794.507466865363, 5931.08068249422, 5956.731947062306, 9277.76805579839, 9447.763805904908, 9454.480003599592, 9560.0, 9562.521873906417, 9444.669436569688, 9710.514474276399, 9842.704718858446, 9861.457619830979, 9936.602535898483, 6798.694058767466, 7246.818829529304, 7464.104307483137, 7475.551466912003, 7583.393328533814, 8167.0, 8167.836643266983, 8231.670733170846, 8241.546714930497, 8243.917560824315, 7183.928160718535, 7312.597807120446, 7324.340809327186, 7389.556626602421, 7436.59098749574, 7060.858782824417, 7218.205997340184, 7223.0, 7229.783106506813, 7305.41556675454, 6910.481713871379, 6919.238883722887, 6960.3735663788475, 6973.965130174317, 6994.125734283215, 4821.2045012572535, 4844.467108617979, 4850.4179498459, 4935.605151587936, 4947.579455746158, 4903.26451032348, 4932.482089380707, 4961.7519124044375, 4966.751662416792, 5128.358955130609], "value": 4574.106761866389, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.87765199790084, 328.7090924531789, 330.3788876911406, 337.38764143080317, 339.1622691950882, 5417.756200970956, 6781.898271525931, 6792.049113124161, 6792.864142717142, 6820.727170913157, 6695.430888374494, 6703.564268322556, 6723.899141512881, 6727.629980351078, 6786.8303292417595, 4786.664933454659, 4827.44484384295, 4970.627202959774, 4975.950240497603, 4987.576056035223, 4913.82801601944, 4970.850874473772, 4974.925376119361, 4981.676191047589, 4991.40103187618, 4915.262710593403, 4929.827456039039, 4931.975340123295, 4940.407151141868, 4952.950470495303, 4933.33399991002, 4941.110600091982, 4958.801647934079, 4960.627952903528, 5011.32347133136, 4277.016286254179, 4281.207976524353, 4289.828406863721, 4299.226139294926, 4307.892302692427, 5434.0, 6348.365163483661, 6519.674016299214, 6567.704453299565, 6570.211574611078, 5899.793507227227, 5917.993941029992, 5970.686448981217, 5975.940240597582, 5981.700914954235, 7207.639618019078, 7251.492395532315, 7255.238199988978, 7261.237570055121, 7270.6001169935635, 4306.923269182705, 4540.636749060067, 4812.446568644581, 4816.036792641451, 4830.7440065583205, 7471.962640186819, 7746.070471543451, 7757.448510297907, 7758.340541054017, 7769.53382797034, 4882.536159064884, 4890.877728056827, 4899.2896030075435, 4908.558229759339, 4914.0, 4137.77242251673, 4911.901761964741, 4982.975085124551, 4987.501249874984, 4997.0, 5925.555583331267, 5930.28836539618, 5930.584859059824, 5945.524358051345, 5950.583459157904, 7377.704891804375, 7379.077615298088, 7403.666834992438, 7416.925830741731, 7417.0, 1716.8369004944511, 1743.8692098092695, 1744.9617477600807, 1744.9651006979789, 1755.692753768111, 990.2375171118199, 1021.2340744441668, 1057.460695045517, 1066.461436974323, 1068.770214403907, 6777.2545020047755, 6804.76183333581, 6831.11195544586, 6842.55523390978, 6843.418309443654, 5725.570582206351, 7399.741009064657, 7584.886226706604, 7617.581033043125, 7636.274553917369, 6291.7797877075, 6325.746970121236, 6866.0, 6970.233274339818, 6975.337342952412, 3013.819170849756, 4036.616521430459, 4039.7072936660575, 4078.0, 4090.427340172378, 8160.061592916772, 8188.877166842502, 8203.507789532647, 8207.138250483733, 8208.0560735515, 7722.343600793995, 7971.880421793678, 7973.521588704696, 8024.398170137263, 8049.51702897828, 8163.469374490639, 8200.220979006985, 8202.179782021869, 8204.179582041748, 8239.588020599065, 7747.72882949094, 7762.262585054411, 7764.301212890867, 7764.650590723318, 7781.5331080135375, 7596.468247222641, 7606.619669016416, 7634.083909930844, 7653.770386888402, 7664.578448185403, 7290.890636640561, 7781.105172905189, 8154.184581541798, 8217.54803485814, 8238.340932725487, 4711.929321060118, 4738.123447162286, 4796.712197268175, 4802.591779698625, 4805.783739731791, 7636.770896873103, 7670.424718146273, 7673.386129109769, 7693.653785579774, 7709.9614501927135, 7396.927445520477, 7402.4448166386655, 7408.666610002455, 7414.22150674193, 7436.73971410998, 7159.248278930637, 7433.8141546461775, 7462.843259294818, 7467.850642987219, 7479.252074792477, 7199.532030418006, 7254.818629534304, 7258.49190556656, 7290.416766658548, 7303.890441643273, 7433.814154645961, 7444.627768611656, 7451.441141914486, 7485.7754267372065, 7511.248875112664, 5723.914141287801, 7226.060612120391, 7276.417886569167, 7291.562506249642, 7296.051513303237], "value": 5344.857635976504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.357898207212, 677.6932593369139, 712.8396110875054, 745.4297462441236, 761.9961900190501, 14896.627584310385, 14932.880033997466, 15066.54800355991, 15073.321700523475, 15123.0, 11521.654350369503, 13842.861571384283, 13855.653608659763, 13897.652558686037, 13911.026228164008, 729.6680010595193, 893.6246776353947, 903.5527413930097, 929.1962452478591, 929.7071422501924, 843.6878355008655, 875.4003507597316, 918.3158546882548, 931.2131249094505, 935.5836652689555, 962.4465932089076, 984.3257368702426, 988.1107003696659, 989.1789814454022, 989.1839232633071, 949.1552518258756, 957.7414098193518, 958.420155805738, 984.050391372322, 985.6599473181741, 715.0668377767012, 721.339973923859, 728.5264578024273, 729.3873146556917, 732.0, 14785.26073696311, 14833.629159270997, 14867.405303787835, 15040.32318545668, 15057.849421505754, 12914.612561623166, 12944.352782360844, 13096.803547946789, 13116.868831311756, 13180.472781088745, 9955.16943171537, 10075.848862267072, 10247.282690211689, 10257.025582569644, 10273.075423211947, 3578.3737845877126, 3590.5152804371596, 3682.9263414731554, 3714.572824125233, 3805.4101614249835, 66233.34416639623, 79702.80445793318, 80389.59805200995, 80603.19396806075, 81055.5947220266, 9627.470489123165, 9692.563834627459, 9771.364861284135, 9805.166560842408, 9942.552585133686, 22418.663720044213, 22589.88705056464, 22803.429914252276, 22806.65790013151, 22840.200592979167, 7607.961960190274, 7763.689452421952, 7914.920850791418, 7994.68021279154, 8075.636596353178, 4157.97921010399, 4183.811728472226, 4203.642690371353, 4204.26425375558, 4419.602235798793, 3718.3121122591865, 3748.775073495599, 3781.149241420658, 3789.052736815796, 3789.829457674411, 674.089978528982, 713.714514194316, 721.1706537481938, 746.4998451037818, 750.7747675697269, 574.7844558290641, 583.201014609987, 601.5067644531442, 609.3053918532876, 613.7238242790762, 7778.444311137795, 8360.45657032291, 8408.285295749807, 8435.451695639764, 8451.53516556583, 545.7053191276746, 581.8080033588906, 593.1843714892024, 593.8426317025992, 604.3503234023442, 3576.1059735066233, 3870.1292209253256, 3938.2911076006594, 3954.5254569451276, 4020.1758639478835, 95073.0, 95461.0, 95689.0, 96757.51621241849, 97043.02956970481, 73637.63181184167, 74566.0, 79958.60020699976, 81018.5949070251, 81643.5917820419, 66835.33164668389, 68714.65642671754, 68747.0, 69771.65114174396, 70116.0, 8406.243438090602, 8427.5786210688, 8544.829103418022, 8559.443636163629, 8643.092475290256, 45924.770376147906, 46542.30186547137, 46713.06573868436, 47423.76288118537, 47929.52070479251, 59222.0, 61604.383956159865, 61927.38072619216, 63165.68417157885, 63396.41508962313, 8253.752387428387, 9746.75633109178, 10360.119389851947, 11152.609658662232, 11435.885641143483, 11582.768344633228, 12165.81751273714, 12200.267983920638, 12213.45039473208, 12303.0, 11257.605983790529, 11264.774704506028, 11352.0, 11547.249428787438, 11671.416429178676, 11244.943775281072, 11285.589301337333, 11299.322040677585, 11477.311361318347, 11667.708307292385, 10580.0, 10793.460326983777, 10840.45797710127, 11015.228933974866, 11422.657320280405, 9321.906780932104, 9413.717588472357, 9543.236541076836, 9708.75728106803, 9802.950985245028, 9397.624095036123, 9693.757656058373, 9706.805863882542, 9716.222702183666, 9796.755081123029], "value": 6951.458121674748, "unit": "score"}], "name": "dromaeo_css", "value": 7632.125360621547, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 120.0, 108.0, 117.0, 118.0, 115.0, 106.0, 116.0, 117.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 116.0, 197.0, 148.0, 150.0, 130.0, 122.0, 138.0, 149.0, 139.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 199.0, 201.0, 198.0, 203.0, 272.0, 191.0, 274.0, 187.0, 272.0], "value": 219.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 85.0, 73.0, 141.0, 58.0, 57.0, 50.0, 61.0, 156.0, 80.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 89.0, 148.0, 77.0, 80.0, 80.0, 119.0, 81.0, 88.0, 157.0], "value": 99.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 117.0, 90.0, 97.0, 117.0, 86.0, 78.0, 129.0, 131.0, 88.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 92.0, 148.0, 147.0, 94.0, 94.0, 96.0, 95.0, 96.0, 95.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 102.0, 90.0, 89.0, 93.0, 92.0, 92.0, 91.0, 92.0, 92.0], "value": 92.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 82.0, 65.0, 61.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 71.0, 68.0, 68.0, 79.0, 74.0, 70.0, 69.0, 69.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 98.0, 70.0, 83.0, 99.0, 94.0, 104.0, 105.0, 104.0, 102.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 146.0, 146.0, 158.0, 116.0, 150.0, 143.0, 169.0, 144.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 168.0, 211.0, 190.0, 214.0, 185.0, 177.0, 179.0, 213.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 69.0, 72.0, 83.0, 96.0, 94.0, 77.0, 65.0], "value": 76.1, "unit": "score"}], "name": "kraken", "value": 1604.5, "alertThreshold": 2.0}]} 16:39:47 INFO - Return code: 0 16:39:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:39:47 ERROR - # TBPL SUCCESS # 16:39:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:47 INFO - 2016-06-02 16:39:47.276 screenresolution[1703:11427] starting screenresolution argv=screenresolution get 16:39:47 INFO - 2016-06-02 16:39:47.279 screenresolution[1703:11427] Display 0: 1600x1200x32@60 16:39:47 INFO - 2016-06-02 16:39:47.284 screenresolution[1704:11430] starting screenresolution argv=screenresolution list 16:39:47 INFO - Available Modes on Display 0 16:39:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:47 INFO - Intel Iris: 16:39:47 INFO - Chipset Model: Intel Iris 16:39:47 INFO - Type: GPU 16:39:47 INFO - Bus: Built-In 16:39:47 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:47 INFO - Vendor: Intel (0x8086) 16:39:47 INFO - Device ID: 0x0a2e 16:39:47 INFO - Revision ID: 0x0009 16:39:47 INFO - Displays: 16:39:47 INFO - Display: 16:39:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:47 INFO - Display Serial Number: 1600x1200 60 16:39:47 INFO - Main Display: Yes 16:39:47 INFO - Mirror: Off 16:39:47 INFO - Online: Yes 16:39:47 INFO - Rotation: Supported 16:39:47 INFO - Return code: 0 16:39:47 INFO - Running post-action listener: _resource_record_post_action 16:39:47 INFO - Running post-run listener: _resource_record_post_run 16:39:48 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 31571456; Write bytes: 659531776; Read time: 203; Write time: 1899 16:39:48 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 345993728; Write bytes: 347043328; Read time: 26509; Write time: 709 16:39:48 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 30641664; Write bytes: 302531072; Read time: 191; Write time: 1154 16:39:48 INFO - Running post-run listener: _upload_blobber_files 16:39:48 INFO - Blob upload gear active. 16:39:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:39:48 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'] 16:39:48 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 16:39:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:39:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:39:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:50 INFO - (blobuploader) - INFO - Done attempting. 16:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:39:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:51 INFO - (blobuploader) - INFO - Done attempting. 16:39:51 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:51 INFO - Return code: 0 16:39:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f66efeb876227db964df46f5c7cbc2154c720f012e55ecd7cefce70085ac221865bb7ee6f192a6f2cd316442c225acee18f47812504f8671817e2a8581104858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d7a8d0e523754a42a7ff12d33b3c22b0e3db4c5b6357058887af29802a93e5961904b1b669aface409521c56aa25624122d3b5c8ed10b4d8a589f4cd789ff59"} 16:39:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:51 INFO - Contents: 16:39:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f66efeb876227db964df46f5c7cbc2154c720f012e55ecd7cefce70085ac221865bb7ee6f192a6f2cd316442c225acee18f47812504f8671817e2a8581104858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d7a8d0e523754a42a7ff12d33b3c22b0e3db4c5b6357058887af29802a93e5961904b1b669aface409521c56aa25624122d3b5c8ed10b4d8a589f4cd789ff59"} 16:39:51 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:51 INFO - Copying logs to upload dir... 16:39:51 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.447477 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-02 16:39:51.577939) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 16:39:51.581828) ========= 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.iiJ582vG1B/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.TjPySPgOHe/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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/f66efeb876227db964df46f5c7cbc2154c720f012e55ecd7cefce70085ac221865bb7ee6f192a6f2cd316442c225acee18f47812504f8671817e2a8581104858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d7a8d0e523754a42a7ff12d33b3c22b0e3db4c5b6357058887af29802a93e5961904b1b669aface409521c56aa25624122d3b5c8ed10b4d8a589f4cd789ff59"} build_url:https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010701 build_url: 'https://queue.taskcluster.net/v1/task/b5C0kRReR7a6hl4kkZL_IA/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/f66efeb876227db964df46f5c7cbc2154c720f012e55ecd7cefce70085ac221865bb7ee6f192a6f2cd316442c225acee18f47812504f8671817e2a8581104858", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d7a8d0e523754a42a7ff12d33b3c22b0e3db4c5b6357058887af29802a93e5961904b1b669aface409521c56aa25624122d3b5c8ed10b4d8a589f4cd789ff59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 16:39:51.617017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:39:51.617442) ========= 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.iiJ582vG1B/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.TjPySPgOHe/Listeners TMPDIR=/var/folders/3y/bnrkybh942z2nnybc81cy8_r00000w/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.005099 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 16:39:51.669093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 16:39:51.669873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 16:39:51.670708) ========= ========= Total master_lag: 0.20 =========