builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0042 starttime: 1467525945.05 results: success (0) buildid: 20160701064957 builduid: dc81e5134e46498e86f7107f4128c56e revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.053786) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.054220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.054502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.446719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.446972) ========= 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.0GVUlfTJRA/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.V3iedEmBaU/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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-07-02 23:05:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-07-02 23:05:46 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.584646 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.073113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.073414) ========= 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.0GVUlfTJRA/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.V3iedEmBaU/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.029634 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.123635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:05:46.124008) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0GVUlfTJRA/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.V3iedEmBaU/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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-07-02 23:05:46,197 truncating revision to first 12 chars 2016-07-02 23:05:46,197 Setting DEBUG logging. 2016-07-02 23:05:46,197 attempt 1/10 2016-07-02 23:05:46,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:05:47,088 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.156633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:05:47.302306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.302629) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.303358) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.303659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.321589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-02 23:05:47.321863) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0GVUlfTJRA/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.V3iedEmBaU/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:05:47 INFO - MultiFileLogger online at 20160702 23:05:47 in /builds/slave/test 23:05:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:05:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:05:47 INFO - {'append_to_log': False, 23:05:47 INFO - 'base_work_dir': '/builds/slave/test', 23:05:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:05:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:05:47 INFO - 'branch': 'Mozilla-Beta', 23:05:47 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:47 INFO - 'config_files': ('talos/mac_config.py',), 23:05:47 INFO - 'default_actions': ('clobber', 23:05:47 INFO - 'read-buildbot-config', 23:05:47 INFO - 'download-and-extract', 23:05:47 INFO - 'populate-webroot', 23:05:47 INFO - 'create-virtualenv', 23:05:47 INFO - 'install', 23:05:47 INFO - 'run-tests'), 23:05:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:47 INFO - 'download_minidump_stackwalk': True, 23:05:47 INFO - 'download_symbols': 'ondemand', 23:05:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:47 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:47 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:47 INFO - 'installer_path': 'installer.exe', 23:05:47 INFO - 'log_level': 'info', 23:05:47 INFO - 'log_name': 'talos', 23:05:47 INFO - 'log_to_console': True, 23:05:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:05:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:05:47 INFO - 'opt_config_files': (), 23:05:47 INFO - 'pip_index': False, 23:05:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:05:47 INFO - 'cmd': ('bash', 23:05:47 INFO - '-c', 23:05:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:05:47 INFO - 'enabled': True, 23:05:47 INFO - 'halt_on_failure': False, 23:05:47 INFO - 'name': 'check_screen_resolution'},), 23:05:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:05:47 INFO - 'cmd': ('bash', 23:05:47 INFO - '-c', 23:05:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:05:47 INFO - 'enabled': True, 23:05:47 INFO - 'halt_on_failure': False, 23:05:47 INFO - 'name': 'check_screen_resolution'},), 23:05:47 INFO - 'run_cmd_checks_enabled': True, 23:05:47 INFO - 'sps_profile': False, 23:05:47 INFO - 'sps_profile_interval': 0, 23:05:47 INFO - 'suite': 'dromaeojs', 23:05:47 INFO - 'system_bits': '32', 23:05:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:47 INFO - 'title': 't-yosemite-r7-0042', 23:05:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:47 INFO - 'use_talos_json': True, 23:05:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:05:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:47 INFO - 'work_dir': 'build'} 23:05:47 INFO - ##### 23:05:47 INFO - ##### Running clobber step. 23:05:47 INFO - ##### 23:05:47 INFO - Running pre-action listener: _resource_record_pre_action 23:05:47 INFO - Running main action method: clobber 23:05:47 INFO - rmtree: /builds/slave/test/build 23:05:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:05:49 INFO - Running post-action listener: _resource_record_post_action 23:05:49 INFO - ##### 23:05:49 INFO - ##### Running read-buildbot-config step. 23:05:49 INFO - ##### 23:05:49 INFO - Running pre-action listener: _resource_record_pre_action 23:05:49 INFO - Running main action method: read_buildbot_config 23:05:49 INFO - Using buildbot properties: 23:05:49 INFO - { 23:05:49 INFO - "project": "", 23:05:49 INFO - "product": "firefox", 23:05:49 INFO - "script_repo_revision": "production", 23:05:49 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 23:05:49 INFO - "repository": "", 23:05:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 23:05:49 INFO - "buildid": "20160701064957", 23:05:49 INFO - "pgo_build": "False", 23:05:49 INFO - "basedir": "/builds/slave/test", 23:05:49 INFO - "buildnumber": 25, 23:05:49 INFO - "slavename": "t-yosemite-r7-0042", 23:05:49 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 23:05:49 INFO - "platform": "yosemite_r7", 23:05:49 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 23:05:49 INFO - "branch": "mozilla-beta", 23:05:49 INFO - "repo_path": "releases/mozilla-beta", 23:05:49 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:05:49 INFO - "stage_platform": "macosx64", 23:05:49 INFO - "builduid": "dc81e5134e46498e86f7107f4128c56e", 23:05:49 INFO - "slavebuilddir": "test" 23:05:49 INFO - } 23:05:49 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg. 23:05:49 INFO - Running post-action listener: _resource_record_post_action 23:05:49 INFO - ##### 23:05:49 INFO - ##### Running download-and-extract step. 23:05:49 INFO - ##### 23:05:49 INFO - Running pre-action listener: _resource_record_pre_action 23:05:49 INFO - Running main action method: download_and_extract 23:05:49 INFO - mkdir: /builds/slave/test/build/tests 23:05:49 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')]} 23:05:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.test_packages.json 23:05:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 23:05:49 INFO - Downloaded 1165 bytes. 23:05:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 23:05:49 INFO - Using the following test package requirements: 23:05:49 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:05:49 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 23:05:49 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 23:05:49 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 23:05:49 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 23:05:49 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 23:05:49 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 23:05:49 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 23:05:49 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 23:05:49 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 23:05:49 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 23:05:49 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 23:05:49 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')]} 23:05:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip 23:05:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 23:05:50 INFO - Downloaded 18351376 bytes. 23:05:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:05:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:05:53 INFO - Return code: 0 23:05:53 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 23:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip 23:05:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 23:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 23:05:53 INFO - Downloaded 18351376 bytes. 23:05:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:05:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:05:57 INFO - Return code: 0 23:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.talos.tests.zip 23:05:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 23:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 23:05:57 INFO - Downloaded 10840145 bytes. 23:05:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:05:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:05:57 INFO - Return code: 0 23:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:05:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:05:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 23:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 23:05:59 INFO - Downloaded 86193481 bytes. 23:05:59 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:05:59 INFO - mkdir: /builds/slave/test/properties 23:05:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:05:59 INFO - Writing to file /builds/slave/test/properties/build_url 23:05:59 INFO - Contents: 23:05:59 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:05:59 INFO - Running post-action listener: _resource_record_post_action 23:05:59 INFO - Running post-action listener: set_extra_try_arguments 23:05:59 INFO - ##### 23:05:59 INFO - ##### Running populate-webroot step. 23:05:59 INFO - ##### 23:05:59 INFO - Running pre-action listener: _resource_record_pre_action 23:05:59 INFO - Running main action method: populate_webroot 23:05:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:59 INFO - '--tppagecycles', 23:05:59 INFO - '7'], 23:05:59 INFO - 'tests': ['tsvgm']}}, 23:05:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['damp', 'tps']}, 23:05:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'tests': ['damp', 'tps']}, 23:05:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['dromaeo_dom']}, 23:05:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tsvgx', 23:05:59 INFO - 'tsvgr_opacity', 23:05:59 INFO - 'tart', 23:05:59 INFO - 'tscrollx', 23:05:59 INFO - 'cart']}, 23:05:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:59 INFO - 'tsvgr_opacity', 23:05:59 INFO - 'tart', 23:05:59 INFO - 'tscrollx', 23:05:59 INFO - 'cart']}, 23:05:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tp5o']}, 23:05:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'tests': ['tp5o']}, 23:05:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s', 23:05:59 INFO - '--xperf_path', 23:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:59 INFO - 'tests': ['tp5n']}, 23:05:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--xperf_path', 23:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:59 INFO - 'tests': ['tp5n']}}, 23:05:59 INFO - 'talos.zip': {'path': '', 23:05:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:59 INFO - Running post-action listener: _resource_record_post_action 23:05:59 INFO - ##### 23:05:59 INFO - ##### Running create-virtualenv step. 23:05:59 INFO - ##### 23:05:59 INFO - Running pre-action listener: _resource_record_pre_action 23:05:59 INFO - Running main action method: create_virtualenv 23:05:59 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:59 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 23:05:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:59 INFO - Using real prefix '/tools/python27' 23:05:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:00 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:02 INFO - Installing pip.................done. 23:06:02 INFO - Return code: 0 23:06:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:03 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 23:06:03 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 23:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:03 INFO - 'HOME': '/Users/cltbld', 23:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:03 INFO - 'LOGNAME': 'cltbld', 23:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:03 INFO - 'MOZ_NO_REMOTE': '1', 23:06:03 INFO - 'NO_EM_RESTART': '1', 23:06:03 INFO - 'PAGER': '/bin/cat', 23:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:03 INFO - 'PWD': '/builds/slave/test', 23:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:03 INFO - 'SHELL': '/bin/bash', 23:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:03 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:03 INFO - 'USER': 'cltbld', 23:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:03 INFO - 'XPC_FLAGS': '0x0', 23:06:03 INFO - 'XPC_SERVICE_NAME': '0', 23:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:03 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 23:06:03 INFO - Cleaning up... 23:06:03 INFO - Return code: 0 23:06:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:03 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:03 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 23:06:03 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 23:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:03 INFO - 'HOME': '/Users/cltbld', 23:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:03 INFO - 'LOGNAME': 'cltbld', 23:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:03 INFO - 'MOZ_NO_REMOTE': '1', 23:06:03 INFO - 'NO_EM_RESTART': '1', 23:06:03 INFO - 'PAGER': '/bin/cat', 23:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:03 INFO - 'PWD': '/builds/slave/test', 23:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:03 INFO - 'SHELL': '/bin/bash', 23:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:03 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:03 INFO - 'USER': 'cltbld', 23:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:03 INFO - 'XPC_FLAGS': '0x0', 23:06:03 INFO - 'XPC_SERVICE_NAME': '0', 23:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:03 INFO - Downloading/unpacking psutil>=0.7.1 23:06:03 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 23:06:03 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 23:06:03 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 23:06:03 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 23:06:03 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 23:06:03 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 23:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:06 INFO - Installing collected packages: psutil 23:06:06 INFO - Running setup.py install for psutil 23:06:06 INFO - building 'psutil._psutil_osx' extension 23:06:06 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 23:06:06 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 23:06:06 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 23:06:07 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 23:06:07 INFO - building 'psutil._psutil_posix' extension 23:06:07 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 23:06:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:06:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:06:07 INFO - ^ 23:06:07 INFO - 1 warning generated. 23:06:07 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 23:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:07 INFO - Successfully installed psutil 23:06:07 INFO - Cleaning up... 23:06:07 INFO - Return code: 0 23:06:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:07 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 23:06:07 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 23:06:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:07 INFO - 'HOME': '/Users/cltbld', 23:06:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:07 INFO - 'LOGNAME': 'cltbld', 23:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:07 INFO - 'MOZ_NO_REMOTE': '1', 23:06:07 INFO - 'NO_EM_RESTART': '1', 23:06:07 INFO - 'PAGER': '/bin/cat', 23:06:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:07 INFO - 'PWD': '/builds/slave/test', 23:06:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:07 INFO - 'SHELL': '/bin/bash', 23:06:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:07 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:07 INFO - 'USER': 'cltbld', 23:06:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:07 INFO - 'XPC_FLAGS': '0x0', 23:06:07 INFO - 'XPC_SERVICE_NAME': '0', 23:06:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:07 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 23:06:07 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 23:06:07 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 23:06:07 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 23:06:07 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 23:06:07 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 23:06:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:06:10 INFO - Installing collected packages: mozsystemmonitor 23:06:10 INFO - Running setup.py install for mozsystemmonitor 23:06:10 INFO - Successfully installed mozsystemmonitor 23:06:10 INFO - Cleaning up... 23:06:10 INFO - Return code: 0 23:06:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:10 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')]} 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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')]} 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:10 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 23:06:10 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 23:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:10 INFO - 'HOME': '/Users/cltbld', 23:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:10 INFO - 'LOGNAME': 'cltbld', 23:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:10 INFO - 'MOZ_NO_REMOTE': '1', 23:06:10 INFO - 'NO_EM_RESTART': '1', 23:06:10 INFO - 'PAGER': '/bin/cat', 23:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:10 INFO - 'PWD': '/builds/slave/test', 23:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:10 INFO - 'SHELL': '/bin/bash', 23:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:10 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:10 INFO - 'USER': 'cltbld', 23:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:10 INFO - 'XPC_FLAGS': '0x0', 23:06:10 INFO - 'XPC_SERVICE_NAME': '0', 23:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:10 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 23:06:10 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 23:06:10 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 23:06:10 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 23:06:10 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 23:06:10 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 23:06:13 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:14 INFO - Downloading docopt-0.6.1.tar.gz 23:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:14 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:14 INFO - Running setup.py install for blobuploader 23:06:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:14 INFO - Running setup.py install for requests 23:06:15 INFO - Running setup.py install for docopt 23:06:15 INFO - Successfully installed blobuploader requests docopt 23:06:15 INFO - Cleaning up... 23:06:15 INFO - Return code: 0 23:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:15 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')]} 23:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:15 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')]} 23:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:15 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:15 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 23:06:15 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 23:06:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:15 INFO - 'HOME': '/Users/cltbld', 23:06:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:15 INFO - 'LOGNAME': 'cltbld', 23:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:15 INFO - 'MOZ_NO_REMOTE': '1', 23:06:15 INFO - 'NO_EM_RESTART': '1', 23:06:15 INFO - 'PAGER': '/bin/cat', 23:06:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:15 INFO - 'PWD': '/builds/slave/test', 23:06:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:15 INFO - 'SHELL': '/bin/bash', 23:06:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:15 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:15 INFO - 'USER': 'cltbld', 23:06:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:15 INFO - 'XPC_FLAGS': '0x0', 23:06:15 INFO - 'XPC_SERVICE_NAME': '0', 23:06:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:15 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-NxI4aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:15 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-1wuywG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:15 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-K6ahVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:15 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-3nkrz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:15 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-wGNi66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-3vtnkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-UHtlz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-_jjmE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-d3Mltd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-WeJOEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-CAJCLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-I3VxYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-8n1cDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-v9X5ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:16 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-diARgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:17 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-GlUJ9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:17 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-E8nUCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:17 INFO - Running setup.py install for manifestparser 23:06:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Running setup.py install for mozcrash 23:06:17 INFO - Running setup.py install for mozdebug 23:06:17 INFO - Running setup.py install for mozdevice 23:06:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Running setup.py install for mozfile 23:06:18 INFO - Running setup.py install for mozhttpd 23:06:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Running setup.py install for mozinfo 23:06:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Running setup.py install for mozInstall 23:06:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Running setup.py install for mozleak 23:06:18 INFO - Running setup.py install for mozlog 23:06:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Running setup.py install for moznetwork 23:06:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Running setup.py install for mozprocess 23:06:19 INFO - Running setup.py install for mozprofile 23:06:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:19 INFO - Running setup.py install for mozrunner 23:06:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:19 INFO - Running setup.py install for mozscreenshot 23:06:19 INFO - Running setup.py install for moztest 23:06:19 INFO - Running setup.py install for mozversion 23:06:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:19 INFO - Cleaning up... 23:06:19 INFO - Return code: 0 23:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:19 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:19 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 23:06:19 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 23:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:19 INFO - 'HOME': '/Users/cltbld', 23:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:19 INFO - 'LOGNAME': 'cltbld', 23:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:19 INFO - 'MOZ_NO_REMOTE': '1', 23:06:19 INFO - 'NO_EM_RESTART': '1', 23:06:19 INFO - 'PAGER': '/bin/cat', 23:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:19 INFO - 'PWD': '/builds/slave/test', 23:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:19 INFO - 'SHELL': '/bin/bash', 23:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:19 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:19 INFO - 'USER': 'cltbld', 23:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:19 INFO - 'XPC_FLAGS': '0x0', 23:06:19 INFO - 'XPC_SERVICE_NAME': '0', 23:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-IvQ0P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-xxlRO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-3hayV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-jiy359-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-9yQbiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-MfeTm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-9uAhy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-u6wVxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:20 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)) 23:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:20 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-c1NIJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-GH6bk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-4MCdJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-2yoZMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-6tOnlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-h6Ap5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-be8Sf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-aRE04D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:21 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)) 23:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:21 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-hqlQAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:21 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)) 23:06:21 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)) 23:06:21 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)) 23:06:21 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)) 23:06:21 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)) 23:06:21 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)) 23:06:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:24 INFO - Downloading blessings-1.6.tar.gz 23:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:24 INFO - Installing collected packages: blessings 23:06:24 INFO - Running setup.py install for blessings 23:06:24 INFO - Successfully installed blessings 23:06:24 INFO - Cleaning up... 23:06:24 INFO - Return code: 0 23:06:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:24 INFO - Reading from file tmpfile_stdout 23:06:24 INFO - Current package versions: 23:06:24 INFO - blessings == 1.6 23:06:24 INFO - blobuploader == 1.2.4 23:06:24 INFO - docopt == 0.6.1 23:06:24 INFO - manifestparser == 1.1 23:06:24 INFO - mozInstall == 1.12 23:06:24 INFO - mozcrash == 0.17 23:06:24 INFO - mozdebug == 0.1 23:06:24 INFO - mozdevice == 0.48 23:06:24 INFO - mozfile == 1.2 23:06:24 INFO - mozhttpd == 0.7 23:06:24 INFO - mozinfo == 0.9 23:06:24 INFO - mozleak == 0.1 23:06:24 INFO - mozlog == 3.1 23:06:24 INFO - moznetwork == 0.27 23:06:24 INFO - mozprocess == 0.22 23:06:24 INFO - mozprofile == 0.28 23:06:24 INFO - mozrunner == 6.11 23:06:24 INFO - mozscreenshot == 0.1 23:06:24 INFO - mozsystemmonitor == 0.0 23:06:24 INFO - moztest == 0.7 23:06:24 INFO - mozversion == 1.4 23:06:24 INFO - psutil == 3.1.1 23:06:24 INFO - requests == 1.2.3 23:06:24 INFO - wsgiref == 0.1.2 23:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:24 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:24 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 23:06:24 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 23:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:24 INFO - 'HOME': '/Users/cltbld', 23:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:24 INFO - 'LOGNAME': 'cltbld', 23:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:24 INFO - 'MOZ_NO_REMOTE': '1', 23:06:24 INFO - 'NO_EM_RESTART': '1', 23:06:24 INFO - 'PAGER': '/bin/cat', 23:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:24 INFO - 'PWD': '/builds/slave/test', 23:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:24 INFO - 'SHELL': '/bin/bash', 23:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:24 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:24 INFO - 'USER': 'cltbld', 23:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:24 INFO - 'XPC_FLAGS': '0x0', 23:06:24 INFO - 'XPC_SERVICE_NAME': '0', 23:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 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)) 23:06:25 INFO - Cleaning up... 23:06:25 INFO - Return code: 0 23:06:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:25 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')]} 23:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:25 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')]} 23:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:25 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:25 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 23:06:25 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 23:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:25 INFO - 'HOME': '/Users/cltbld', 23:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:25 INFO - 'LOGNAME': 'cltbld', 23:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:25 INFO - 'MOZ_NO_REMOTE': '1', 23:06:25 INFO - 'NO_EM_RESTART': '1', 23:06:25 INFO - 'PAGER': '/bin/cat', 23:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:25 INFO - 'PWD': '/builds/slave/test', 23:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:25 INFO - 'SHELL': '/bin/bash', 23:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:25 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:25 INFO - 'USER': 'cltbld', 23:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:25 INFO - 'XPC_FLAGS': '0x0', 23:06:25 INFO - 'XPC_SERVICE_NAME': '0', 23:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:25 INFO - Downloading/unpacking jsonschema 23:06:25 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 23:06:25 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 23:06:25 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 23:06:25 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 23:06:25 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 23:06:25 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 23:06:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:27 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:28 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:28 INFO - warning: no files found matching '*.txt' 23:06:28 INFO - no previously-included directories found matching 'build' 23:06:28 INFO - no previously-included directories found matching 'dist' 23:06:28 INFO - no previously-included directories found matching '.git*' 23:06:28 INFO - Installing collected packages: jsonschema, functools32 23:06:28 INFO - Running setup.py install for functools32 23:06:28 INFO - warning: no files found matching '*.txt' 23:06:28 INFO - no previously-included directories found matching 'build' 23:06:28 INFO - no previously-included directories found matching 'dist' 23:06:28 INFO - no previously-included directories found matching '.git*' 23:06:28 INFO - Successfully installed jsonschema functools32 23:06:28 INFO - Cleaning up... 23:06:28 INFO - Return code: 0 23:06:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:28 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 0x107ff2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108002420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a4a2c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, '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.0GVUlfTJRA/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.V3iedEmBaU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 23:06:28 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 23:06:28 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 23:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:28 INFO - 'HOME': '/Users/cltbld', 23:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:28 INFO - 'LOGNAME': 'cltbld', 23:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:28 INFO - 'MOZ_NO_REMOTE': '1', 23:06:28 INFO - 'NO_EM_RESTART': '1', 23:06:28 INFO - 'PAGER': '/bin/cat', 23:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:28 INFO - 'PWD': '/builds/slave/test', 23:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:28 INFO - 'SHELL': '/bin/bash', 23:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:28 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:28 INFO - 'USER': 'cltbld', 23:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:28 INFO - 'XPC_FLAGS': '0x0', 23:06:28 INFO - 'XPC_SERVICE_NAME': '0', 23:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:29 INFO - Downloading/unpacking flake8 23:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:32 INFO - no previously-included directories found matching 'docs/_build' 23:06:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:32 INFO - Running setup.py install for pep8 23:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:32 INFO - no previously-included directories found matching 'docs/_build' 23:06:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:32 INFO - Cleaning up... 23:06:33 INFO - Return code: 0 23:06:33 INFO - Running post-action listener: _resource_record_post_action 23:06:33 INFO - Running post-action listener: _start_resource_monitoring 23:06:33 INFO - Starting resource monitoring. 23:06:33 INFO - ##### 23:06:33 INFO - ##### Running install step. 23:06:33 INFO - ##### 23:06:33 INFO - Running pre-action listener: _resource_record_pre_action 23:06:33 INFO - Running main action method: install 23:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:33 INFO - Reading from file tmpfile_stdout 23:06:33 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:33 INFO - Reading from file tmpfile_stdout 23:06:33 INFO - Output received: 23:06:33 INFO - Usage: mozinstall [options] installer 23:06:33 INFO - Options: 23:06:33 INFO - -h, --help show this help message and exit 23:06:33 INFO - -d DEST, --destination=DEST 23:06:33 INFO - Directory to install application into. [default: 23:06:33 INFO - "/builds/slave/test"] 23:06:33 INFO - --app=APP Application being installed. [default: firefox] 23:06:33 INFO - mkdir: /builds/slave/test/build/application 23:06:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 23:06:55 INFO - Reading from file tmpfile_stdout 23:06:55 INFO - Output received: 23:06:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 23:06:55 INFO - Running post-action listener: _resource_record_post_action 23:06:55 INFO - ##### 23:06:55 INFO - ##### Running run-tests step. 23:06:55 INFO - ##### 23:06:55 INFO - Running pre-action listener: _resource_record_pre_action 23:06:55 INFO - Running main action method: run_tests 23:06:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:06:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:06:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:06:55 INFO - 2016-07-02 23:06:55.248 screenresolution[1662:12642] starting screenresolution argv=screenresolution get 23:06:55 INFO - 2016-07-02 23:06:55.250 screenresolution[1662:12642] Display 0: 1600x1200x32@60 23:06:55 INFO - 2016-07-02 23:06:55.256 screenresolution[1663:12644] starting screenresolution argv=screenresolution list 23:06:55 INFO - Available Modes on Display 0 23:06:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:06:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:06:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:06:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:06:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:06:55 INFO - Intel Iris: 23:06:55 INFO - Chipset Model: Intel Iris 23:06:55 INFO - Type: GPU 23:06:55 INFO - Bus: Built-In 23:06:55 INFO - VRAM (Dynamic, Max): 1536 MB 23:06:55 INFO - Vendor: Intel (0x8086) 23:06:55 INFO - Device ID: 0x0a2e 23:06:55 INFO - Revision ID: 0x0009 23:06:55 INFO - Displays: 23:06:55 INFO - Display: 23:06:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:06:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:06:55 INFO - Display Serial Number: 1600x1200 60 23:06:55 INFO - Main Display: Yes 23:06:55 INFO - Mirror: Off 23:06:55 INFO - Online: Yes 23:06:55 INFO - Rotation: Supported 23:06:55 INFO - Return code: 0 23:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:55 INFO - Python 2.7.3 23:06:55 INFO - Return code: 0 23:06:55 INFO - grabbing minidump binary from tooltool 23:06:55 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')]} 23:06:55 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 0x107e91e00>, '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 0x107cfadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e8cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:55 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 23:06:55 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 23:06:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:55 INFO - Return code: 0 23:06:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:06:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:06:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:06:56 INFO - Return code: 0 23:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:06:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0GVUlfTJRA/Render', 23:06:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:56 INFO - 'HOME': '/Users/cltbld', 23:06:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:56 INFO - 'LOGNAME': 'cltbld', 23:06:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:56 INFO - 'MOZ_NO_REMOTE': '1', 23:06:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:56 INFO - 'NO_EM_RESTART': '1', 23:06:56 INFO - 'PAGER': '/bin/cat', 23:06:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:56 INFO - 'PWD': '/builds/slave/test', 23:06:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:56 INFO - 'SHELL': '/bin/bash', 23:06:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.V3iedEmBaU/Listeners', 23:06:56 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 23:06:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:56 INFO - 'USER': 'cltbld', 23:06:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:56 INFO - 'XPC_FLAGS': '0x0', 23:06:56 INFO - 'XPC_SERVICE_NAME': '0', 23:06:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:06:56 INFO - mozversion application_buildid: 20160701064957 23:06:56 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:56 INFO - mozversion application_display_name: Firefox 23:06:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:56 INFO - mozversion application_name: Firefox 23:06:56 INFO - mozversion application_remotingname: firefox 23:06:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:56 INFO - mozversion application_vendor: Mozilla 23:06:56 INFO - mozversion application_version: 48.0 23:06:56 INFO - mozversion platform_buildid: 20160701064957 23:06:56 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:56 INFO - mozversion platform_version: 48.0 23:06:56 INFO - using testdate: 1467526016 23:06:56 INFO - actual date: 1467526016 23:06:56 INFO - starting webserver on 'localhost:49274' 23:06:56 INFO - SUITE-START | Running 2 tests 23:06:56 INFO - TEST-START | dromaeo_css 23:06:56 INFO - operating with platform_type : mac_ 23:06:56 INFO - Initialising browser for dromaeo_css test... 23:06:56 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmp9TiORR/profile http://localhost:49274/getInfo.html) 23:06:59 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 23:06:59 INFO - PROCESS | 1681 | colorDepth:24 23:06:59 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 23:06:59 INFO - PROCESS | 1681 | __metrics 23:06:59 INFO - PROCESS | 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:06:59 ERROR - PROCESS | 1681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:06:59 INFO - TEST-INFO | 1681: exit 0 23:06:59 INFO - Browser initialized. 23:06:59 INFO - Running cycle 1/1 for dromaeo_css test... 23:06:59 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmp9TiORR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:11 INFO - PROCESS | 1685 | RSS: Main: 161628160 23:07:11 INFO - PROCESS | 1685 | 23:08:02 INFO - PROCESS | 1685 | 1467526082865 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] 23:10:12 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 23:10:13 INFO - PROCESS | 1685 | RSS: Main: 261533696 23:10:13 INFO - PROCESS | 1685 | 23:13:16 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 23:13:17 INFO - PROCESS | 1685 | RSS: Main: 308563968 23:13:17 INFO - PROCESS | 1685 | 23:16:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 23:16:19 INFO - PROCESS | 1685 | RSS: Main: 307937280 23:16:19 INFO - PROCESS | 1685 | 23:19:21 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 23:19:22 INFO - PROCESS | 1685 | RSS: Main: 309878784 23:19:22 INFO - PROCESS | 1685 | 23:22:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 23:22:26 INFO - PROCESS | 1685 | RSS: Main: 270942208 23:22:26 INFO - PROCESS | 1685 | 23:25:28 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 23:25:29 INFO - PROCESS | 1685 | RSS: Main: 316530688 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | __start_tp_report 23:25:29 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 23:25:29 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 23:25:29 INFO - PROCESS | 1685 | |i|pagename|runs| 23:25:29 INFO - PROCESS | 1685 | |0;dojo.html;3279.3933122372364;3595.7303202259836;3595.9101022474433;3614.2410093880267;3657.652523010313;5788.594798364116;5810.941890581093;5817.214676018736;5831.53347732182;5865.120231965202;5849.619774714641;5858.179854820318;5861.325947516037;5861.824145275638;5868.559858010655;5228.111221092414;5266.7366631668265;5270.683758974455;5312.73436328184;5327.121025030865;5336.67979921204;5368.979893820181;5380.623356365037;5385.111456609674;5387.138057910735;5286.127788914824;5347.946520534803;5372.328458942632;5372.865678358034;5377.784888604451;5335.279737235482;5371.086915224382;5372.91940620891;5383.380911195184;5409.729513524348;5180.766865491062;5232.764525596357;5307.336582927134;5318.335208098988;5321.787128514855;4764.356811830427;5722.055860782966;5760.654360738369;5818.6217895836635;5848.795292164754;6246.593971391845;6266.874662506724;6279;6282.057691346335;6290.591111577733;6171.876562468726;6217.098520714471;6342.841428964267;6344.302126766052;6351.047342898556;6014.578979471439;6022.748183477459;6036.3360030396625;6055.283027342107;6072.45347918685;6365.618062916147;6416.486681065504;6419.069234960998;6425.614463132133;6432;6120.325235636462;6177.073438984098;6266.060090986297;6272.686365681698;6292.370762923671;6330.715117819709;6332.651704156316;6341.936580634227;6347;6356.650384228912;6227.1282020517165;6267.62394256346;6271.96864015677;6279.843003924939;6281;6193.535484838655;6227.408396202353;6262.906056409158;6295.527835412362;6297.181366422427;5054.721990290569;5074.492550744896;5077.771500282496;5090.898182036339;5095.337606111182;4470.173017991617;4579.839705610288;4586.518415566385;4589.724616523019;4603.769811509411;5997.220361352996;6097.878042439215;6102.359252278536;6106.961816491207;6138.907916381258;6253.343398943137;6292.811215663537;6302.590331628429;6308.621482711052;6311.936880631227;5933.495652869468;5970.820875373745;5997.610155339889;6010.308814486302;6023.909641355383;5580;5584.246126772834;5594.104943209067;5600.775968961278;5628.324601047901;6484.805455836333;6564.081028655992;6567.34326567349;6569.408753212234;6575.671216439063;6194.845128871814;6220.533459990428;6263.749450021948;6280.434760871361;6319.936800631935;6542.803715888531;6577.177852768404;6580.177477815273;6581.111549940888;6583.3087525811015;6270.090836828543;6289.056641503811;6292.8426789328805;6302.054691796267;6318.905216421849;6216.347283535164;6246.937530624636;6289.245290565162;6301.991681330965;6317.336679648571;6165.876682466415;6220.688965551613;6224.1597384354345;6233.345498722569;6242.188515493139;6014.488768454556;6179.0422484514975;6227.719752611053;6230.937690623035;6235.937640623536;5998.910016349845;6029.698515074141;6115.605440958429;6152.815415537541;6183.474404675473;5361.410244872983;6159.5072394209255;6265.749370025148;6289.119523266838;6289.559730818799;6170;6182.783602573888;6194.9690251550255;6212.285587157535;6227.097070924781 23:25:29 INFO - PROCESS | 1685 | |1;ext.html;516.3726072821526;526.1213772999091;535.5394360849671;603.9642013946082;666.9728617928388;31373.686263137362;37973.05067373317;38865.41701874474;38894;38918.416223756634;43339.78330108353;43894.34158487625;43941.560584394145;44003.77998110005;44022.7798861006;8932.196102350787;9769.462679552604;9960.800783984316;10003.349782264166;11530;11629.24409913353;11739.7065073373;11757.470913808856;11760.647180584596;11768.941155294211;11697.766044679101;11790.764184716301;11795.705107372341;11797.823032654516;11798.646040618794;11642.825357619642;11712.882871171265;11715.472803723767;11718.88281117195;11736.941315293368;11552.133589980785;11943.925046745835;11944.223625464403;11959.641210763692;11962.102842286864;39210.607893920984;39358.606413935784;39411.802940985115;39528.20943581141;39661;3069.877204911801;3143.465610846162;3226.322472280824;3274.590676165479;3909.8029623047505;29085.41829163426;29372.8531357344;29417.70582294171;29532.409351813058;29648.365573088897;2715.660542432196;2770.1135636596296;2806.635137432141;2849.28767808048;2884.365439603284;399725;405382;405510;406018;407264;37307.88076357714;63456;64085.679571601846;64103.679481602296;64114.358856410836;35730.928072157876;35897.923062308175;35980.460293095624;35981.46027809585;35996.64003359933;15460.613484662974;15792.763108553381;15814.209289535478;15823.446179383667;15848.128352940468;12719.427625756864;12724.236545807282;13612.523561675294;13642;13776.10455320401;8222.054463736627;8223.671053157927;8249;8310.418270721113;8317.209865062809;3496.5629296337956;3500.43992961125;3523.489094081344;3534.4874993125854;3566.3937130687846;982.6364245229167;1008.1380419741016;1095.4522738630685;1111.8165502692127;1150.2006105756418;30446.54330185049;30461.93383231576;30909.845450773053;31012.0696379109;31104.84447577793;1076.3380520979542;1109.6670998700358;1155.78040172367;1217.9634610961684;1228.5515786737776;15450.0729956203;15545.922270388575;15641.843581564039;15846.890717649654;15987.280572374038;651076;652142;659175;661357;661999;61059;61803;61843;61876.76246475135;62217.9999999991;1498.6628008697955;1565.2017471089825;1583.4062226665;1589.3404237241646;1591.2362066208054;27103.72896271012;28380.864765409977;29646.258843529085;30161.69838301589;30408.84795576008;49156.50843491662;49903.500964989886;49985.250221247436;50132.49867501279;50277;461436;480662;481765.9117044064;482131;482161;37239.813800930824;44203.557964419946;45733;47358.76320618375;47817.76091119522;45884.31173532466;46261.30608040815;47342.81642958953;47776.7611161942;48962.755186225266;39474;39526.802365987984;39625;40079;40687.59312406838;38425.6157438422;38729;38772.030699232746;39738;40242.59757402389;38628.613713863626;38632.841014769605;38888.22223555457;38907.02732431712;39052.804735977275;27223.183304500897;32325.676743232267;33714.15714607154;33758.49362259617;33765.66234337625;24878.626820597343;25094.12170574021;25280.494390112464;25652.23043308629;26036.34909127287 23:25:29 INFO - PROCESS | 1685 | |2;jquery.html;413.216953872412;417.73891317926297;419.7775179155049;422.26525845029647;425.58080290913443;19093.281604655578;21697.457563560918;21724.782752172494;22282.777172228274;23001.4249643759;11904.583339583116;12219.572314968978;16159.757603635926;21240.89379553104;21310.786892131073;5422.864428389283;5467.835964921039;5645.54835613152;5690.004249256384;6279.623222606635;6203.8138855834395;6211.254649442073;6244.406781355764;6246.562740608137;6256.343083976185;5793.594448388614;6104.908426373586;6110.602810817305;6232.220972378453;6249.062640603923;6033.245844269466;6047.606905551147;6061.060535616986;6067.848303792396;6085.817425477243;5855.443732845373;5872.29532456108;5896.469317761422;5943.613665111797;5956.255468066492;13549.390277437538;13943.721125577533;13963.441462341494;14083.436662533486;14168.716625667532;2236.273211206348;2253.3803204118835;2254.830887683414;2346.894389752465;2797.832130072182;9901.950490247575;9902.158316543102;10327.638532651321;12676.746465070739;15512.61218469536;1729.7405389191722;1755.324200182926;1789.498940296719;1791.9820801791946;1856.2389420337731;77999;95598;125492;129339.99999999905;129418;9710.417374957526;10397.896021039693;11386.544538218544;11437.485313160927;11780.293182409083;14245;14709.676129148427;14744.705105897821;15449.38202471911;15790.526284211492;7505.512141710771;8293.58532073406;8537.701180458655;8548.829023419497;9122.726318210463;9244.722658320261;9254.259659227246;9259.351845370895;9379.343445958853;9380.108889655472;4735.242361222188;4804.135255654016;4817.879553011133;4822.324874517571;4867.148249056401;1717.639295747882;2011.1151093518804;2024.5647185854818;2052.692096185584;2054.719261619601;926.9304802139867;954.5131982688879;971.6939164163266;981.6613268422383;1037.4501514197486;21182.682259765807;21684.89157554202;21730.78269217319;21890.45273868166;21903;1019.4444028004755;1031.6750223679517;1033.3748082410034;1036.362636978268;1072.3673032910465;9387.6714315;11247.381394023243;11646.534138634359;11668.124890633237;11703.2978021319;647977;652599.737001312;653708;672231;672432;91401;128184;129053;129724;132044;1025.2003437318904;1032.6230925712212;1047.0733400940223;1047.4082143589;1048.7168464514539;13845.653858653613;15271.303189638786;18916.14877330551;19339;19732.70400943958;54326.728366357915;54969.45030549803;55076.449235507134;56028.71985640046;56647;82493.58753206195;82869;83658.74511882449;84104;85506.28987420093;6973.476989225727;7616.581088040211;8451.915480845113;8524.190201930807;8666.133386661284;9757.902420975699;13060.934695326463;13173.341332933507;13309.201447913156;13504.324783760969;11480.942595287304;11613.954744073075;11665.533378664759;11680.415979201176;11857.762844742885;11297.887021129683;11300.717482063013;11366.318020918772;11495.597654082067;11574.47914843851;11752;11876.096197865421;11933.343666098448;11934.4032798358;11941.82087268709;6973.4072603829245;8084.474509156886;8324.62539185726;8491;8655.264302534355;10342.32774869631;11607.013403860428;11794.233374830608;11899.702507437038;11920.880791191978 23:25:29 INFO - PROCESS | 1685 | |3;mootools.html;1510.4033906606883;1667.449741585277;1693.635868288318;2040.571479989202;2102.106604693005;7989.760307190786;8774.912250877489;8921.464712117278;8958.77603059923;8963.820723585524;8591.226789588936;8807.295416366691;8814.911850881505;8831.514266715345;8845.336599755012;2538.276591171512;2558.462722828199;2559.897604095834;2561.3596600849787;2563.0772921748157;2479.1446950801947;2545.6563363945907;2549.2734570647367;2549.579319412295;2558.1302357198547;2534.733852945442;2556.884940177687;2561.7566331198504;2563.8333508321994;2565.294544000396;2517.9118730844334;2536.074332868499;2552.808539359546;2571.871406429671;2579.200447861169;2364.6571247169063;2504.136073054793;2551.9234422967343;2552.7574880386333;2556.6931968163753;8497.320214382835;8701.738947831574;9035.367524273304;9109.271258299386;9152.450852948778;5509.531689806371;5595.944040559583;5601.019821531257;5611.2144299798065;5642.915356269659;3580.23025049613;3673.7244706646843;3699.2046709957217;3699.223163135745;3706.610805865399;895.4627223665814;1045.132539991805;1062.550820359072;1077.466654006264;1079.4117206122683;11783.764324713544;12193.268403895707;12204.267743935392;12206.816897746541;12206.962408195313;4587.472440669299;4705.811767529329;4718.669693121448;4722.669413141047;4761.976190119027;9475.147236748726;9477.431354118775;9477.905220947703;9489;9499.76250593727;5428.022955867903;5430.13117901134;5459.590530710213;5463.125899856004;5467.261919640877;4611.515790841981;4777.617790576745;4998.600111991032;5105.6681315715105;5107.948920510822;3315.303786204876;3491.969868888684;3841.250956063541;3859.6333348331864;3961.3661814109605;1140.1562843495753;1200.9699757505957;1201.1111777284746;1216.647172320035;1219.603628820637;958.9089036541517;967.4775621164492;980.3186785184229;995.7751965082989;999.7100840756244;5000.867861836439;5943.821685349447;6047.0627052806885;6132.386761323921;6161.983272760034;470.83050101963266;477.61074724099745;486.96347773917097;491.15276148644017;493.0557981465525;3878.379459286557;4025.295573274665;4053.2298863215897;4086.325756250245;4127.628513433745;10867.45662716861;11179.273347232403;11213.878612138884;11227.438628068563;11233.494492747846;10720.785584288271;11053.060489858291;11061.834072488919;11152.330860148417;11200.663980080612;8531.189536993976;8628.439151455135;8674.956625216959;8727.60725767342;8846.95576522126;5831.4168583141345;5846.824595262149;5905;6002.519798416029;6061.636301821904;9806.166475849634;9843.360181588174;9881.357711749;9916.652917147865;10084.899151008689;8474.27968622674;9774.511274436107;10490.632827850988;10508;10527.315724477885;6538.607683539003;6670.199576050905;6892.172939247122;7153.82115447118;7268.781936541912;8444.535550544779;8452.36607254446;8506.362022848187;8508.446950948168;8512.914870851213;7329.120505539369;7400.666969986256;7455.627218639155;7568.205338439385;7605.353544948742;7316.085489313836;7328.633568321456;7371.8157046074275;7385.556866587807;7518.323350898446;7117.644117794193;7136.7145314186855;7181.06646135999;7181.210066892742;7190.640467976685;4629.722216667011;4949.6287778416045;5008.77460514285;5091.007253585515;5097.8725531862;4988.152014157529;5064.569511591556;5076.757874642161;5133.845984620468;5282.947170528246 23:25:29 INFO - PROCESS | 1685 | |4;prototype.html;333.57252293311086;334.1495892952436;341.84958618208003;342.9416999110151;345.6301757119882;6701.095352127461;6727.79816605502;6753.561018533798;6810.62541560214;6816.420604248632;6422.229332480098;6475.773347932812;6634.469242460604;6675.66621668917;6737.5620584661965;4907.11671899058;4926.45808961014;4929.186684197103;4950;4961.032598643266;4952.405711314647;4961.05739909416;4982.651214414992;4983.978284451697;4985.975070124644;4703.811847526094;4715.292706094079;4833.806647734086;4859.125357435661;4912.435069966946;4853.927191092136;4865.708057516543;4866.951330486685;4877.170880950247;4910.533499317559;4194.182134483777;4223.113146239293;4224.619784219404;4229.429027081366;4233;6470.870582588322;6474.546781725281;6480.351964803482;6487.513436492235;6491.350864913518;5878.941210587882;5908.113782932552;5916.497097746696;5918.585699001072;5925.822225333247;6931.202911665173;7156.749513767045;7170.390516806077;7178.4616153788675;7190.101237345332;4768.165571025057;4797.736124513151;4806.158922188603;4807.879803004917;4828.130936431441;7549.320561149523;7565.394768418569;7568.318851303409;7569.470137090406;7571.810704732316;4847.933454639973;4850.490698476679;4882.048000639841;4886.413630364308;4889.584385327216;3679.19057807282;4509.481409637933;4905.288733133747;4964.659541923733;4973.52751488608;5673.687947162945;5873.089671100986;5897.911531327033;5913.615614985012;5929.436703513159;7107.324804143598;7155.499115061895;7185.748498802517;7190;7199.3520583147765;1634.8610368118605;1710.9743353849701;1733.826617338256;1735.6788994036144;1741.4079213067619;1056.0864851903048;1106.2201148190507;1124.3197865291545;1125.6791814332876;1127.3067063755732;6660.83347916306;6677.966610166918;6708.530402871752;6711.731530738716;6738.528303018742;7401.888971665429;7418.703251869865;7419.146798118178;7424.183339832614;7430.108386993596;6699.598024118569;6710.966445167841;6721.462283017445;6721.630310332881;6724;3791.9431208531896;3884.3008258513737;3925.175713100281;3942.940855887164;3946.2699400610977;7747.031621047369;7757.224277572311;7763.534187948741;7766.106897706723;7786.1435242123325;7589.316961473494;7600.9619951900995;7647.808804779925;7662.885056724153;7665.540067595962;6285.779997700059;7749.302562769265;7749.7287594933905;7771.028621422322;7782.688692452239;7082.362587367162;7374.078240219973;7391.667374968032;7399.778006659809;7413.66638501258;7168.390686791681;7202.819929501804;7219.783406497813;7239.565626062453;7249.818754531179;6174.9691251545255;7716.074071111502;7716.884246736416;7727.729529466442;7759.456838021284;4884.48712885142;4891.5353041461;4894.535019173173;4896.2655601660035;4904.705717656952;7104.183018952886;7324.974503569611;7326.93759404894;7359.926400735924;7380.852382952418;6197.96901015492;6870.484713646597;7126.429885609243;7190.1731300901065;7215.67529461186;5778.913316300175;7190.4966652335925;7204.459665525212;7206.89189662145;7206.927930720625;7027.543209691354;7045.542039767399;7046.682899269443;7046.823829404306;7063.894041589278;6896.965515172392;6950.721971121098;7192.100987376578;7223;7235.312645298688;6915.688794004182;6916.3429474199875;7016.543924644881;7033.296670332926;7037.964810175917 23:25:29 INFO - PROCESS | 1685 | |5;yui.html;730.8465222303316;778.4939789137064;779.1896427715177;780.0054929964294;796.0407708711;15351.078935263891;15673.92163039186;15680.215989200551;15694.136822474773;15728.685426291468;14330.57008289753;14422.495212667558;14460.493882714107;14463.421463141489;14484.493042743507;670.7657909446617;809.2433574607732;964.2912459342413;1005.0150852164883;1011.8684571005759;986.2455221755328;994.2692121290845;1003.4029752297408;1004.2518323848743;1006.416278558438;1044.4412239451894;1044.791041791641;1044.8955104489567;1045.2160879340495;1045.3309881675734;763.9388848892075;846.2045677063571;859.510079254825;861.0227391910196;1025.723054775214;791;791.4301702773994;792.5007245435339;792.7700966719702;795.1531618825932;15262.38950441981;15315.387384504607;15324.693506129926;15365.846341536553;15409.922950385288;11478.483468243949;12746;13027.28349940753;13256.73486530264;13300.3349832508;10306.433146176958;10354.17166626668;10380.221483388701;10430.947845260725;10583.153347732163;3532.293541291752;3625.3836847735947;3632.146445585285;3638.2359704462096;3701.68535674468;82628.58685706533;84283;84604.15395846024;84816.15183848144;84838.15161848364;9760.609575617038;10036.849447258297;10252;10445.268831181744;10473.057424831803;23952.760472395403;23972.52054958926;23985.760142398703;24025;24067.27798166058;7678.961605191938;7727.227277272228;7739.5743234122665;7800.414968877243;8019.438639295194;4186.769727664947;4200.516940551875;4247.341662042389;4345.3699213613845;4398.604125628709;3774.584795672474;3804.752691075071;3845.5000849889334;3852.3065848147044;3852.8844134676006;664.4883439751364;675.0144788608686;677.7526202935992;687.0484379134834;703.9331263529956;554.5425024354923;575.7581815637442;590.5954421221477;609.5763444406184;629.1726379810534;6782.762603308861;8036.598170091589;8432.53621050848;8485.915140848636;8589.48463092204;536.2760273630646;586.4633860018035;590.6721769417928;607.9604825686316;611.3122736920964;3872.8450861965207;3952.9802350988634;3995.180987897474;4038.394240863835;4110.568390319033;77974;95501;97433.5128324368;97491.51254243683;97882.02117978872;82764.58617706993;82772.58613706892;83224;83518;83988.16011839804;65579.67210163918;68399.3160068403;68463;68704.6564767173;73816.63091684507;7813.570253636105;7831.451798374287;7964.601769911597;8062.427826573997;8379.622916968628;48104.759476202395;48179.277310839665;49188.75405622949;49948.001039979725;50332.24501632405;55151;64844.02733959089;70217;70588;71491.64254178696;10264.743381415525;10446.955304469493;10631.893681063091;11113.555457781598;11913.761724765283;11823.704407389883;12041.157119001586;12069.034477241976;12447.315397653216;12867.163634363736;11268.887311126784;11444.198906076495;11614.709632258922;11730.237534560227;11730.88556587123;11518.078553715515;11694.649160525198;11695;11820.054395648156;11834.467448964646;11325.546978120783;11594.6521604352;11623.37824040654;11804.350760708243;11827.994620457357;9505.382150160218;9953.104220620178;10118.139958103644;10271.332363396356;10340.896591033994;9903.356281841658;10057.24570657189;10095;10146.289759716748;10160.034796694303 23:25:29 INFO - PROCESS | 1685 | __end_tp_report 23:25:29 INFO - PROCESS | 1685 | __start_cc_report 23:25:29 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,957 23:25:29 INFO - PROCESS | 1685 | __end_cc_report 23:25:29 INFO - PROCESS | 1685 | __startTimestamp1467527129015__endTimestamp 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | ------- Summary: start ------- 23:25:29 INFO - PROCESS | 1685 | Number of tests: 6 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | [#0] dojo.html Cycles:165 Average:5875.37 Median:6159.51 stddev:632.52 (10.3%) stddev-sans-first:600.79 23:25:29 INFO - PROCESS | 1685 | Values: 3279.4 3595.7 3595.9 3614.2 3657.7 5788.6 5810.9 5817.2 5831.5 5865.1 5849.6 5858.2 5861.3 5861.8 5868.6 5228.1 5266.7 5270.7 5312.7 5327.1 5336.7 5369.0 5380.6 5385.1 5387.1 5286.1 5347.9 5372.3 5372.9 5377.8 5335.3 5371.1 5372.9 5383.4 5409.7 5180.8 5232.8 5307.3 5318.3 5321.8 4764.4 5722.1 5760.7 5818.6 5848.8 6246.6 6266.9 6279.0 6282.1 6290.6 6171.9 6217.1 6342.8 6344.3 6351.0 6014.6 6022.7 6036.3 6055.3 6072.5 6365.6 6416.5 6419.1 6425.6 6432.0 6120.3 6177.1 6266.1 6272.7 6292.4 6330.7 6332.7 6341.9 6347.0 6356.7 6227.1 6267.6 6272.0 6279.8 6281.0 6193.5 6227.4 6262.9 6295.5 6297.2 5054.7 5074.5 5077.8 5090.9 5095.3 4470.2 4579.8 4586.5 4589.7 4603.8 5997.2 6097.9 6102.4 6107.0 6138.9 6253.3 6292.8 6302.6 6308.6 6311.9 5933.5 5970.8 5997.6 6010.3 6023.9 5580.0 5584.2 5594.1 5600.8 5628.3 6484.8 6564.1 6567.3 6569.4 6575.7 6194.8 6220.5 6263.7 6280.4 6319.9 6542.8 6577.2 6580.2 6581.1 6583.3 6270.1 6289.1 6292.8 6302.1 6318.9 6216.3 6246.9 6289.2 6302.0 6317.3 6165.9 6220.7 6224.2 6233.3 6242.2 6014.5 6179.0 6227.7 6230.9 6235.9 5998.9 6029.7 6115.6 6152.8 6183.5 5361.4 6159.5 6265.7 6289.1 6289.6 6170.0 6182.8 6195.0 6212.3 6227.1 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | [#1] ext.html Cycles:180 Average:65190.21 Median:19648.66 stddev:139989.99 (712.5%) stddev-sans-first:140298.48 23:25:29 INFO - PROCESS | 1685 | Values: 516.4 526.1 535.5 604.0 667.0 31373.7 37973.1 38865.4 38894.0 38918.4 43339.8 43894.3 43941.6 44003.8 44022.8 8932.2 9769.5 9960.8 10003.3 11530.0 11629.2 11739.7 11757.5 11760.6 11768.9 11697.8 11790.8 11795.7 11797.8 11798.6 11642.8 11712.9 11715.5 11718.9 11736.9 11552.1 11943.9 11944.2 11959.6 11962.1 39210.6 39358.6 39411.8 39528.2 39661.0 3069.9 3143.5 3226.3 3274.6 3909.8 29085.4 29372.9 29417.7 29532.4 29648.4 2715.7 2770.1 2806.6 2849.3 2884.4 399725.0 405382.0 405510.0 406018.0 407264.0 37307.9 63456.0 64085.7 64103.7 64114.4 35730.9 35897.9 35980.5 35981.5 35996.6 15460.6 15792.8 15814.2 15823.4 15848.1 12719.4 12724.2 13612.5 13642.0 13776.1 8222.1 8223.7 8249.0 8310.4 8317.2 3496.6 3500.4 3523.5 3534.5 3566.4 982.6 1008.1 1095.5 1111.8 1150.2 30446.5 30461.9 30909.8 31012.1 31104.8 1076.3 1109.7 1155.8 1218.0 1228.6 15450.1 15545.9 15641.8 15846.9 15987.3 651076.0 652142.0 659175.0 661357.0 661999.0 61059.0 61803.0 61843.0 61876.8 62218.0 1498.7 1565.2 1583.4 1589.3 1591.2 27103.7 28380.9 29646.3 30161.7 30408.8 49156.5 49903.5 49985.3 50132.5 50277.0 461436.0 480662.0 481765.9 482131.0 482161.0 37239.8 44203.6 45733.0 47358.8 47817.8 45884.3 46261.3 47342.8 47776.8 48962.8 39474.0 39526.8 39625.0 40079.0 40687.6 38425.6 38729.0 38772.0 39738.0 40242.6 38628.6 38632.8 38888.2 38907.0 39052.8 27223.2 32325.7 33714.2 33758.5 33765.7 24878.6 25094.1 25280.5 25652.2 26036.3 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | [#2] jquery.html Cycles:180 Average:36382.44 Median:22092.89 stddev:109524.32 (495.7%) stddev-sans-first:109798.26 23:25:29 INFO - PROCESS | 1685 | Values: 413.2 417.7 419.8 422.3 425.6 19093.3 21697.5 21724.8 22282.8 23001.4 11904.6 12219.6 16159.8 21240.9 21310.8 5422.9 5467.8 5645.5 5690.0 6279.6 6203.8 6211.3 6244.4 6246.6 6256.3 5793.6 6104.9 6110.6 6232.2 6249.1 6033.2 6047.6 6061.1 6067.8 6085.8 5855.4 5872.3 5896.5 5943.6 5956.3 13549.4 13943.7 13963.4 14083.4 14168.7 2236.3 2253.4 2254.8 2346.9 2797.8 9902.0 9902.2 10327.6 12676.7 15512.6 1729.7 1755.3 1789.5 1792.0 1856.2 77999.0 95598.0 125492.0 129340.0 129418.0 9710.4 10397.9 11386.5 11437.5 11780.3 14245.0 14709.7 14744.7 15449.4 15790.5 7505.5 8293.6 8537.7 8548.8 9122.7 9244.7 9254.3 9259.4 9379.3 9380.1 4735.2 4804.1 4817.9 4822.3 4867.1 1717.6 2011.1 2024.6 2052.7 2054.7 926.9 954.5 971.7 981.7 1037.5 21182.7 21684.9 21730.8 21890.5 21903.0 1019.4 1031.7 1033.4 1036.4 1072.4 9387.7 11247.4 11646.5 11668.1 11703.3 647977.0 652599.7 653708.0 672231.0 672432.0 91401.0 128184.0 129053.0 129724.0 132044.0 1025.2 1032.6 1047.1 1047.4 1048.7 13845.7 15271.3 18916.1 19339.0 19732.7 54326.7 54969.5 55076.4 56028.7 56647.0 82493.6 82869.0 83658.7 84104.0 85506.3 6973.5 7616.6 8451.9 8524.2 8666.1 9757.9 13060.9 13173.3 13309.2 13504.3 11480.9 11614.0 11665.5 11680.4 11857.8 11297.9 11300.7 11366.3 11495.6 11574.5 11752.0 11876.1 11933.3 11934.4 11941.8 6973.4 8084.5 8324.6 8491.0 8655.3 10342.3 11607.0 11794.2 11899.7 11920.9 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | [#3] mootools.html Cycles:180 Average:5784.68 Median:5036.67 stddev:3240.40 (64.3%) stddev-sans-first:3233.57 23:25:29 INFO - PROCESS | 1685 | Values: 1510.4 1667.4 1693.6 2040.6 2102.1 7989.8 8774.9 8921.5 8958.8 8963.8 8591.2 8807.3 8814.9 8831.5 8845.3 2538.3 2558.5 2559.9 2561.4 2563.1 2479.1 2545.7 2549.3 2549.6 2558.1 2534.7 2556.9 2561.8 2563.8 2565.3 2517.9 2536.1 2552.8 2571.9 2579.2 2364.7 2504.1 2551.9 2552.8 2556.7 8497.3 8701.7 9035.4 9109.3 9152.5 5509.5 5595.9 5601.0 5611.2 5642.9 3580.2 3673.7 3699.2 3699.2 3706.6 895.5 1045.1 1062.6 1077.5 1079.4 11783.8 12193.3 12204.3 12206.8 12207.0 4587.5 4705.8 4718.7 4722.7 4762.0 9475.1 9477.4 9477.9 9489.0 9499.8 5428.0 5430.1 5459.6 5463.1 5467.3 4611.5 4777.6 4998.6 5105.7 5107.9 3315.3 3492.0 3841.3 3859.6 3961.4 1140.2 1201.0 1201.1 1216.6 1219.6 958.9 967.5 980.3 995.8 999.7 5000.9 5943.8 6047.1 6132.4 6162.0 470.8 477.6 487.0 491.2 493.1 3878.4 4025.3 4053.2 4086.3 4127.6 10867.5 11179.3 11213.9 11227.4 11233.5 10720.8 11053.1 11061.8 11152.3 11200.7 8531.2 8628.4 8675.0 8727.6 8847.0 5831.4 5846.8 5905.0 6002.5 6061.6 9806.2 9843.4 9881.4 9916.7 10084.9 8474.3 9774.5 10490.6 10508.0 10527.3 6538.6 6670.2 6892.2 7153.8 7268.8 8444.5 8452.4 8506.4 8508.4 8512.9 7329.1 7400.7 7455.6 7568.2 7605.4 7316.1 7328.6 7371.8 7385.6 7518.3 7117.6 7136.7 7181.1 7181.2 7190.6 4629.7 4949.6 5008.8 5091.0 5097.9 4988.2 5064.6 5076.8 5133.8 5282.9 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | [#4] prototype.html Cycles:180 Average:5873.03 Median:6700.35 stddev:1852.14 (27.6%) stddev-sans-first:1810.07 23:25:29 INFO - PROCESS | 1685 | Values: 333.6 334.1 341.8 342.9 345.6 6701.1 6727.8 6753.6 6810.6 6816.4 6422.2 6475.8 6634.5 6675.7 6737.6 4907.1 4926.5 4929.2 4950.0 4961.0 4952.4 4961.1 4982.7 4984.0 4986.0 4703.8 4715.3 4833.8 4859.1 4912.4 4853.9 4865.7 4867.0 4877.2 4910.5 4194.2 4223.1 4224.6 4229.4 4233.0 6470.9 6474.5 6480.4 6487.5 6491.4 5878.9 5908.1 5916.5 5918.6 5925.8 6931.2 7156.7 7170.4 7178.5 7190.1 4768.2 4797.7 4806.2 4807.9 4828.1 7549.3 7565.4 7568.3 7569.5 7571.8 4847.9 4850.5 4882.0 4886.4 4889.6 3679.2 4509.5 4905.3 4964.7 4973.5 5673.7 5873.1 5897.9 5913.6 5929.4 7107.3 7155.5 7185.7 7190.0 7199.4 1634.9 1711.0 1733.8 1735.7 1741.4 1056.1 1106.2 1124.3 1125.7 1127.3 6660.8 6678.0 6708.5 6711.7 6738.5 7401.9 7418.7 7419.1 7424.2 7430.1 6699.6 6711.0 6721.5 6721.6 6724.0 3791.9 3884.3 3925.2 3942.9 3946.3 7747.0 7757.2 7763.5 7766.1 7786.1 7589.3 7601.0 7647.8 7662.9 7665.5 6285.8 7749.3 7749.7 7771.0 7782.7 7082.4 7374.1 7391.7 7399.8 7413.7 7168.4 7202.8 7219.8 7239.6 7249.8 6175.0 7716.1 7716.9 7727.7 7759.5 4884.5 4891.5 4894.5 4896.3 4904.7 7104.2 7325.0 7326.9 7359.9 7380.9 6198.0 6870.5 7126.4 7190.2 7215.7 5778.9 7190.5 7204.5 7206.9 7206.9 7027.5 7045.5 7046.7 7046.8 7063.9 6897.0 6950.7 7192.1 7223.0 7235.3 6915.7 6916.3 7016.5 7033.3 7038.0 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - PROCESS | 1685 | [#5] yui.html Cycles:180 Average:18696.36 Median:4074.48 stddev:26220.15 (643.5%) stddev-sans-first:26259.00 23:25:29 INFO - PROCESS | 1685 | Values: 730.8 778.5 779.2 780.0 796.0 15351.1 15673.9 15680.2 15694.1 15728.7 14330.6 14422.5 14460.5 14463.4 14484.5 670.8 809.2 964.3 1005.0 1011.9 986.2 994.3 1003.4 1004.3 1006.4 1044.4 1044.8 1044.9 1045.2 1045.3 763.9 846.2 859.5 861.0 1025.7 791.0 791.4 792.5 792.8 795.2 15262.4 15315.4 15324.7 15365.8 15409.9 11478.5 12746.0 13027.3 13256.7 13300.3 10306.4 10354.2 10380.2 10430.9 10583.2 3532.3 3625.4 3632.1 3638.2 3701.7 82628.6 84283.0 84604.2 84816.2 84838.2 9760.6 10036.8 10252.0 10445.3 10473.1 23952.8 23972.5 23985.8 24025.0 24067.3 7679.0 7727.2 7739.6 7800.4 8019.4 4186.8 4200.5 4247.3 4345.4 4398.6 3774.6 3804.8 3845.5 3852.3 3852.9 664.5 675.0 677.8 687.0 703.9 554.5 575.8 590.6 609.6 629.2 6782.8 8036.6 8432.5 8485.9 8589.5 536.3 586.5 590.7 608.0 611.3 3872.8 3953.0 3995.2 4038.4 4110.6 77974.0 95501.0 97433.5 97491.5 97882.0 82764.6 82772.6 83224.0 83518.0 83988.2 65579.7 68399.3 68463.0 68704.7 73816.6 7813.6 7831.5 7964.6 8062.4 8379.6 48104.8 48179.3 49188.8 49948.0 50332.2 55151.0 64844.0 70217.0 70588.0 71491.6 10264.7 10447.0 10631.9 11113.6 11913.8 11823.7 12041.2 12069.0 12447.3 12867.2 11268.9 11444.2 11614.7 11730.2 11730.9 11518.1 11694.6 11695.0 11820.1 11834.5 11325.5 11594.7 11623.4 11804.4 11828.0 9505.4 9953.1 10118.1 10271.3 10340.9 9903.4 10057.2 10095.0 10146.3 10160.0 23:25:29 INFO - PROCESS | 1685 | -------- Summary: end -------- 23:25:29 INFO - PROCESS | 1685 | 23:25:29 INFO - TEST-INFO | 1685: exit 0 23:25:29 INFO - TEST-OK | dromaeo_css | took 1112663ms 23:25:29 INFO - TEST-START | kraken 23:25:29 INFO - operating with platform_type : mac_ 23:25:29 INFO - Initialising browser for kraken test... 23:25:29 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpSxUEVX/profile http://localhost:49274/getInfo.html) 23:25:31 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 23:25:31 INFO - PROCESS | 1691 | colorDepth:24 23:25:31 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 23:25:31 INFO - PROCESS | 1691 | __metrics 23:25:31 INFO - PROCESS | 1691 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:25:31 ERROR - PROCESS | 1691 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:25:32 INFO - TEST-INFO | 1691: exit 0 23:25:32 INFO - Browser initialized. 23:25:32 INFO - Running cycle 1/1 for kraken test... 23:25:32 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpSxUEVX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:44 INFO - PROCESS | 1694 | RSS: Main: 161546240 23:25:44 INFO - PROCESS | 1694 | 23:25:46 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:47 INFO - PROCESS | 1694 | RSS: Main: 223842304 23:25:47 INFO - PROCESS | 1694 | 23:25:50 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 23:25:51 INFO - PROCESS | 1694 | RSS: Main: 240472064 23:25:51 INFO - PROCESS | 1694 | 23:25:54 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 23:25:54 INFO - PROCESS | 1694 | RSS: Main: 325165056 23:25:54 INFO - PROCESS | 1694 | 23:25:56 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 23:25:57 INFO - PROCESS | 1694 | RSS: Main: 230481920 23:25:57 INFO - PROCESS | 1694 | 23:25:59 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:00 INFO - PROCESS | 1694 | RSS: Main: 230764544 23:26:00 INFO - PROCESS | 1694 | 23:26:03 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:03 INFO - PROCESS | 1694 | RSS: Main: 268320768 23:26:03 INFO - PROCESS | 1694 | 23:26:06 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:07 INFO - PROCESS | 1694 | RSS: Main: 269926400 23:26:07 INFO - PROCESS | 1694 | 23:26:09 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 23:26:10 INFO - PROCESS | 1694 | RSS: Main: 268541952 23:26:10 INFO - PROCESS | 1694 | 23:26:11 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:12 INFO - PROCESS | 1694 | RSS: Main: 260501504 23:26:12 INFO - PROCESS | 1694 | 23:26:14 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:15 INFO - PROCESS | 1694 | RSS: Main: 266776576 23:26:15 INFO - PROCESS | 1694 | 23:26:17 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:18 INFO - PROCESS | 1694 | RSS: Main: 270635008 23:26:18 INFO - PROCESS | 1694 | 23:26:20 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:21 INFO - PROCESS | 1694 | RSS: Main: 278032384 23:26:21 INFO - PROCESS | 1694 | 23:26:24 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:24 INFO - PROCESS | 1694 | RSS: Main: 274935808 23:26:24 INFO - PROCESS | 1694 | 23:26:26 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 23:26:27 INFO - PROCESS | 1694 | RSS: Main: 336060416 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | __start_tp_report 23:26:27 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 23:26:27 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 23:26:27 INFO - PROCESS | 1694 | |i|pagename|runs| 23:26:27 INFO - PROCESS | 1694 | |0;ai-astar;112;110;122;110;109;112;113;112;113;132 23:26:27 INFO - PROCESS | 1694 | |1;audio-beat-detection;158;119;145;185;150;170;167;99;191;147 23:26:27 INFO - PROCESS | 1694 | |2;audio-dft;184;183;183;188;182;184;186;198;257;184 23:26:27 INFO - PROCESS | 1694 | |3;audio-fft;69;78;74;177;57;55;57;82;164;62 23:26:27 INFO - PROCESS | 1694 | |4;audio-oscillator;92;91;136;80;79;86;125;78;78;157 23:26:27 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;86;87;88;84;86;83;86;84;86;85 23:26:27 INFO - PROCESS | 1694 | |6;imaging-darkroom;92;91;92;93;91;101;98;92;92;92 23:26:27 INFO - PROCESS | 1694 | |7;imaging-desaturate;84;86;83;82;83;83;85;83;83;85 23:26:27 INFO - PROCESS | 1694 | |8;json-parse-financial;61;62;62;63;64;62;63;80;58;56 23:26:27 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;61;65;62;70;66;69;71;65;65;65 23:26:27 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;81;93;102;72;82;91;105;104;106;74 23:26:27 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;128;127;125;125;123;123;124;123;147;139 23:26:27 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;162;212;219;178;165;165;174;222;219;173 23:26:27 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;67;68;68;68;73;97;96;77;67;69 23:26:27 INFO - PROCESS | 1694 | __end_tp_report 23:26:27 INFO - PROCESS | 1694 | __start_cc_report 23:26:27 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,1967 23:26:27 INFO - PROCESS | 1694 | __end_cc_report 23:26:27 INFO - PROCESS | 1694 | __startTimestamp1467527187041__endTimestamp 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | ------- Summary: start ------- 23:26:27 INFO - PROCESS | 1694 | Number of tests: 14 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:114.50 Median:112.50 stddev:7.12 (6.3%) stddev-sans-first:7.50 23:26:27 INFO - PROCESS | 1694 | Values: 112.0 110.0 122.0 110.0 109.0 112.0 113.0 112.0 113.0 132.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:168.50 stddev:28.20 (16.7%) stddev-sans-first:29.86 23:26:27 INFO - PROCESS | 1694 | Values: 158.0 119.0 145.0 185.0 150.0 170.0 167.0 99.0 191.0 147.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:192.90 Median:185.00 stddev:22.99 (12.4%) stddev-sans-first:24.16 23:26:27 INFO - PROCESS | 1694 | Values: 184.0 183.0 183.0 188.0 182.0 184.0 186.0 198.0 257.0 184.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:87.50 Median:65.50 stddev:44.81 (68.4%) stddev-sans-first:47.03 23:26:27 INFO - PROCESS | 1694 | Values: 69.0 78.0 74.0 177.0 57.0 55.0 57.0 82.0 164.0 62.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:100.20 Median:79.50 stddev:28.52 (35.9%) stddev-sans-first:30.09 23:26:27 INFO - PROCESS | 1694 | Values: 92.0 91.0 136.0 80.0 79.0 86.0 125.0 78.0 78.0 157.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 23:26:27 INFO - PROCESS | 1694 | Values: 86.0 87.0 88.0 84.0 86.0 83.0 86.0 84.0 86.0 85.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:92.00 stddev:3.34 (3.6%) stddev-sans-first:3.50 23:26:27 INFO - PROCESS | 1694 | Values: 92.0 91.0 92.0 93.0 91.0 101.0 98.0 92.0 92.0 92.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:83.50 stddev:1.25 (1.5%) stddev-sans-first:1.32 23:26:27 INFO - PROCESS | 1694 | Values: 84.0 86.0 83.0 82.0 83.0 83.0 85.0 83.0 83.0 85.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:62.50 stddev:6.42 (10.3%) stddev-sans-first:6.76 23:26:27 INFO - PROCESS | 1694 | Values: 61.0 62.0 62.0 63.0 64.0 62.0 63.0 80.0 58.0 56.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.50 stddev:3.25 (5.0%) stddev-sans-first:2.92 23:26:27 INFO - PROCESS | 1694 | Values: 61.0 65.0 62.0 70.0 66.0 69.0 71.0 65.0 65.0 65.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:77.50 stddev:13.11 (16.9%) stddev-sans-first:13.39 23:26:27 INFO - PROCESS | 1694 | Values: 81.0 93.0 102.0 72.0 82.0 91.0 105.0 104.0 106.0 74.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:126.00 stddev:8.10 (6.4%) stddev-sans-first:8.59 23:26:27 INFO - PROCESS | 1694 | Values: 128.0 127.0 125.0 125.0 123.0 123.0 124.0 123.0 147.0 139.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.90 Median:195.00 stddev:25.61 (13.1%) stddev-sans-first:25.24 23:26:27 INFO - PROCESS | 1694 | Values: 162.0 212.0 219.0 178.0 165.0 165.0 174.0 222.0 219.0 173.0 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:71.00 stddev:11.76 (16.6%) stddev-sans-first:12.11 23:26:27 INFO - PROCESS | 1694 | Values: 67.0 68.0 68.0 68.0 73.0 97.0 96.0 77.0 67.0 69.0 23:26:27 INFO - PROCESS | 1694 | -------- Summary: end -------- 23:26:27 INFO - PROCESS | 1694 | 23:26:27 INFO - TEST-INFO | 1694: exit 0 23:26:27 INFO - TEST-OK | kraken | took 58238ms 23:26:27 INFO - SUITE-END | took 1170s 23:26:28 INFO - Completed test suite (00:19:31) 23:26:28 INFO - javascript benchmark 23:26:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.3933122372364, 3595.7303202259836, 3595.9101022474433, 3614.2410093880267, 3657.652523010313, 5788.594798364116, 5810.941890581093, 5817.214676018736, 5831.53347732182, 5865.120231965202, 5849.619774714641, 5858.179854820318, 5861.325947516037, 5861.824145275638, 5868.559858010655, 5228.111221092414, 5266.7366631668265, 5270.683758974455, 5312.73436328184, 5327.121025030865, 5336.67979921204, 5368.979893820181, 5380.623356365037, 5385.111456609674, 5387.138057910735, 5286.127788914824, 5347.946520534803, 5372.328458942632, 5372.865678358034, 5377.784888604451, 5335.279737235482, 5371.086915224382, 5372.91940620891, 5383.380911195184, 5409.729513524348, 5180.766865491062, 5232.764525596357, 5307.336582927134, 5318.335208098988, 5321.787128514855, 4764.356811830427, 5722.055860782966, 5760.654360738369, 5818.6217895836635, 5848.795292164754, 6246.593971391845, 6266.874662506724, 6279.0, 6282.057691346335, 6290.591111577733, 6171.876562468726, 6217.098520714471, 6342.841428964267, 6344.302126766052, 6351.047342898556, 6014.578979471439, 6022.748183477459, 6036.3360030396625, 6055.283027342107, 6072.45347918685, 6365.618062916147, 6416.486681065504, 6419.069234960998, 6425.614463132133, 6432.0, 6120.325235636462, 6177.073438984098, 6266.060090986297, 6272.686365681698, 6292.370762923671, 6330.715117819709, 6332.651704156316, 6341.936580634227, 6347.0, 6356.650384228912, 6227.1282020517165, 6267.62394256346, 6271.96864015677, 6279.843003924939, 6281.0, 6193.535484838655, 6227.408396202353, 6262.906056409158, 6295.527835412362, 6297.181366422427, 5054.721990290569, 5074.492550744896, 5077.771500282496, 5090.898182036339, 5095.337606111182, 4470.173017991617, 4579.839705610288, 4586.518415566385, 4589.724616523019, 4603.769811509411, 5997.220361352996, 6097.878042439215, 6102.359252278536, 6106.961816491207, 6138.907916381258, 6253.343398943137, 6292.811215663537, 6302.590331628429, 6308.621482711052, 6311.936880631227, 5933.495652869468, 5970.820875373745, 5997.610155339889, 6010.308814486302, 6023.909641355383, 5580.0, 5584.246126772834, 5594.104943209067, 5600.775968961278, 5628.324601047901, 6484.805455836333, 6564.081028655992, 6567.34326567349, 6569.408753212234, 6575.671216439063, 6194.845128871814, 6220.533459990428, 6263.749450021948, 6280.434760871361, 6319.936800631935, 6542.803715888531, 6577.177852768404, 6580.177477815273, 6581.111549940888, 6583.3087525811015, 6270.090836828543, 6289.056641503811, 6292.8426789328805, 6302.054691796267, 6318.905216421849, 6216.347283535164, 6246.937530624636, 6289.245290565162, 6301.991681330965, 6317.336679648571, 6165.876682466415, 6220.688965551613, 6224.1597384354345, 6233.345498722569, 6242.188515493139, 6014.488768454556, 6179.0422484514975, 6227.719752611053, 6230.937690623035, 6235.937640623536, 5998.910016349845, 6029.698515074141, 6115.605440958429, 6152.815415537541, 6183.474404675473, 5361.410244872983, 6159.5072394209255, 6265.749370025148, 6289.119523266838, 6289.559730818799, 6170.0, 6182.783602573888, 6194.9690251550255, 6212.285587157535, 6227.097070924781], "value": 5836.50426943724, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.3726072821526, 526.1213772999091, 535.5394360849671, 603.9642013946082, 666.9728617928388, 31373.686263137362, 37973.05067373317, 38865.41701874474, 38894.0, 38918.416223756634, 43339.78330108353, 43894.34158487625, 43941.560584394145, 44003.77998110005, 44022.7798861006, 8932.196102350787, 9769.462679552604, 9960.800783984316, 10003.349782264166, 11530.0, 11629.24409913353, 11739.7065073373, 11757.470913808856, 11760.647180584596, 11768.941155294211, 11697.766044679101, 11790.764184716301, 11795.705107372341, 11797.823032654516, 11798.646040618794, 11642.825357619642, 11712.882871171265, 11715.472803723767, 11718.88281117195, 11736.941315293368, 11552.133589980785, 11943.925046745835, 11944.223625464403, 11959.641210763692, 11962.102842286864, 39210.607893920984, 39358.606413935784, 39411.802940985115, 39528.20943581141, 39661.0, 3069.877204911801, 3143.465610846162, 3226.322472280824, 3274.590676165479, 3909.8029623047505, 29085.41829163426, 29372.8531357344, 29417.70582294171, 29532.409351813058, 29648.365573088897, 2715.660542432196, 2770.1135636596296, 2806.635137432141, 2849.28767808048, 2884.365439603284, 399725.0, 405382.0, 405510.0, 406018.0, 407264.0, 37307.88076357714, 63456.0, 64085.679571601846, 64103.679481602296, 64114.358856410836, 35730.928072157876, 35897.923062308175, 35980.460293095624, 35981.46027809585, 35996.64003359933, 15460.613484662974, 15792.763108553381, 15814.209289535478, 15823.446179383667, 15848.128352940468, 12719.427625756864, 12724.236545807282, 13612.523561675294, 13642.0, 13776.10455320401, 8222.054463736627, 8223.671053157927, 8249.0, 8310.418270721113, 8317.209865062809, 3496.5629296337956, 3500.43992961125, 3523.489094081344, 3534.4874993125854, 3566.3937130687846, 982.6364245229167, 1008.1380419741016, 1095.4522738630685, 1111.8165502692127, 1150.2006105756418, 30446.54330185049, 30461.93383231576, 30909.845450773053, 31012.0696379109, 31104.84447577793, 1076.3380520979542, 1109.6670998700358, 1155.78040172367, 1217.9634610961684, 1228.5515786737776, 15450.0729956203, 15545.922270388575, 15641.843581564039, 15846.890717649654, 15987.280572374038, 651076.0, 652142.0, 659175.0, 661357.0, 661999.0, 61059.0, 61803.0, 61843.0, 61876.76246475135, 62217.9999999991, 1498.6628008697955, 1565.2017471089825, 1583.4062226665, 1589.3404237241646, 1591.2362066208054, 27103.72896271012, 28380.864765409977, 29646.258843529085, 30161.69838301589, 30408.84795576008, 49156.50843491662, 49903.500964989886, 49985.250221247436, 50132.49867501279, 50277.0, 461436.0, 480662.0, 481765.9117044064, 482131.0, 482161.0, 37239.813800930824, 44203.557964419946, 45733.0, 47358.76320618375, 47817.76091119522, 45884.31173532466, 46261.30608040815, 47342.81642958953, 47776.7611161942, 48962.755186225266, 39474.0, 39526.802365987984, 39625.0, 40079.0, 40687.59312406838, 38425.6157438422, 38729.0, 38772.030699232746, 39738.0, 40242.59757402389, 38628.613713863626, 38632.841014769605, 38888.22223555457, 38907.02732431712, 39052.804735977275, 27223.183304500897, 32325.676743232267, 33714.15714607154, 33758.49362259617, 33765.66234337625, 24878.626820597343, 25094.12170574021, 25280.494390112464, 25652.23043308629, 26036.34909127287], "value": 19503.160809285848, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.216953872412, 417.73891317926297, 419.7775179155049, 422.26525845029647, 425.58080290913443, 19093.281604655578, 21697.457563560918, 21724.782752172494, 22282.777172228274, 23001.4249643759, 11904.583339583116, 12219.572314968978, 16159.757603635926, 21240.89379553104, 21310.786892131073, 5422.864428389283, 5467.835964921039, 5645.54835613152, 5690.004249256384, 6279.623222606635, 6203.8138855834395, 6211.254649442073, 6244.406781355764, 6246.562740608137, 6256.343083976185, 5793.594448388614, 6104.908426373586, 6110.602810817305, 6232.220972378453, 6249.062640603923, 6033.245844269466, 6047.606905551147, 6061.060535616986, 6067.848303792396, 6085.817425477243, 5855.443732845373, 5872.29532456108, 5896.469317761422, 5943.613665111797, 5956.255468066492, 13549.390277437538, 13943.721125577533, 13963.441462341494, 14083.436662533486, 14168.716625667532, 2236.273211206348, 2253.3803204118835, 2254.830887683414, 2346.894389752465, 2797.832130072182, 9901.950490247575, 9902.158316543102, 10327.638532651321, 12676.746465070739, 15512.61218469536, 1729.7405389191722, 1755.324200182926, 1789.498940296719, 1791.9820801791946, 1856.2389420337731, 77999.0, 95598.0, 125492.0, 129339.99999999905, 129418.0, 9710.417374957526, 10397.896021039693, 11386.544538218544, 11437.485313160927, 11780.293182409083, 14245.0, 14709.676129148427, 14744.705105897821, 15449.38202471911, 15790.526284211492, 7505.512141710771, 8293.58532073406, 8537.701180458655, 8548.829023419497, 9122.726318210463, 9244.722658320261, 9254.259659227246, 9259.351845370895, 9379.343445958853, 9380.108889655472, 4735.242361222188, 4804.135255654016, 4817.879553011133, 4822.324874517571, 4867.148249056401, 1717.639295747882, 2011.1151093518804, 2024.5647185854818, 2052.692096185584, 2054.719261619601, 926.9304802139867, 954.5131982688879, 971.6939164163266, 981.6613268422383, 1037.4501514197486, 21182.682259765807, 21684.89157554202, 21730.78269217319, 21890.45273868166, 21903.0, 1019.4444028004755, 1031.6750223679517, 1033.3748082410034, 1036.362636978268, 1072.3673032910465, 9387.6714315, 11247.381394023243, 11646.534138634359, 11668.124890633237, 11703.2978021319, 647977.0, 652599.737001312, 653708.0, 672231.0, 672432.0, 91401.0, 128184.0, 129053.0, 129724.0, 132044.0, 1025.2003437318904, 1032.6230925712212, 1047.0733400940223, 1047.4082143589, 1048.7168464514539, 13845.653858653613, 15271.303189638786, 18916.14877330551, 19339.0, 19732.70400943958, 54326.728366357915, 54969.45030549803, 55076.449235507134, 56028.71985640046, 56647.0, 82493.58753206195, 82869.0, 83658.74511882449, 84104.0, 85506.28987420093, 6973.476989225727, 7616.581088040211, 8451.915480845113, 8524.190201930807, 8666.133386661284, 9757.902420975699, 13060.934695326463, 13173.341332933507, 13309.201447913156, 13504.324783760969, 11480.942595287304, 11613.954744073075, 11665.533378664759, 11680.415979201176, 11857.762844742885, 11297.887021129683, 11300.717482063013, 11366.318020918772, 11495.597654082067, 11574.47914843851, 11752.0, 11876.096197865421, 11933.343666098448, 11934.4032798358, 11941.82087268709, 6973.4072603829245, 8084.474509156886, 8324.62539185726, 8491.0, 8655.264302534355, 10342.32774869631, 11607.013403860428, 11794.233374830608, 11899.702507437038, 11920.880791191978], "value": 9642.672575831044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.4033906606883, 1667.449741585277, 1693.635868288318, 2040.571479989202, 2102.106604693005, 7989.760307190786, 8774.912250877489, 8921.464712117278, 8958.77603059923, 8963.820723585524, 8591.226789588936, 8807.295416366691, 8814.911850881505, 8831.514266715345, 8845.336599755012, 2538.276591171512, 2558.462722828199, 2559.897604095834, 2561.3596600849787, 2563.0772921748157, 2479.1446950801947, 2545.6563363945907, 2549.2734570647367, 2549.579319412295, 2558.1302357198547, 2534.733852945442, 2556.884940177687, 2561.7566331198504, 2563.8333508321994, 2565.294544000396, 2517.9118730844334, 2536.074332868499, 2552.808539359546, 2571.871406429671, 2579.200447861169, 2364.6571247169063, 2504.136073054793, 2551.9234422967343, 2552.7574880386333, 2556.6931968163753, 8497.320214382835, 8701.738947831574, 9035.367524273304, 9109.271258299386, 9152.450852948778, 5509.531689806371, 5595.944040559583, 5601.019821531257, 5611.2144299798065, 5642.915356269659, 3580.23025049613, 3673.7244706646843, 3699.2046709957217, 3699.223163135745, 3706.610805865399, 895.4627223665814, 1045.132539991805, 1062.550820359072, 1077.466654006264, 1079.4117206122683, 11783.764324713544, 12193.268403895707, 12204.267743935392, 12206.816897746541, 12206.962408195313, 4587.472440669299, 4705.811767529329, 4718.669693121448, 4722.669413141047, 4761.976190119027, 9475.147236748726, 9477.431354118775, 9477.905220947703, 9489.0, 9499.76250593727, 5428.022955867903, 5430.13117901134, 5459.590530710213, 5463.125899856004, 5467.261919640877, 4611.515790841981, 4777.617790576745, 4998.600111991032, 5105.6681315715105, 5107.948920510822, 3315.303786204876, 3491.969868888684, 3841.250956063541, 3859.6333348331864, 3961.3661814109605, 1140.1562843495753, 1200.9699757505957, 1201.1111777284746, 1216.647172320035, 1219.603628820637, 958.9089036541517, 967.4775621164492, 980.3186785184229, 995.7751965082989, 999.7100840756244, 5000.867861836439, 5943.821685349447, 6047.0627052806885, 6132.386761323921, 6161.983272760034, 470.83050101963266, 477.61074724099745, 486.96347773917097, 491.15276148644017, 493.0557981465525, 3878.379459286557, 4025.295573274665, 4053.2298863215897, 4086.325756250245, 4127.628513433745, 10867.45662716861, 11179.273347232403, 11213.878612138884, 11227.438628068563, 11233.494492747846, 10720.785584288271, 11053.060489858291, 11061.834072488919, 11152.330860148417, 11200.663980080612, 8531.189536993976, 8628.439151455135, 8674.956625216959, 8727.60725767342, 8846.95576522126, 5831.4168583141345, 5846.824595262149, 5905.0, 6002.519798416029, 6061.636301821904, 9806.166475849634, 9843.360181588174, 9881.357711749, 9916.652917147865, 10084.899151008689, 8474.27968622674, 9774.511274436107, 10490.632827850988, 10508.0, 10527.315724477885, 6538.607683539003, 6670.199576050905, 6892.172939247122, 7153.82115447118, 7268.781936541912, 8444.535550544779, 8452.36607254446, 8506.362022848187, 8508.446950948168, 8512.914870851213, 7329.120505539369, 7400.666969986256, 7455.627218639155, 7568.205338439385, 7605.353544948742, 7316.085489313836, 7328.633568321456, 7371.8157046074275, 7385.556866587807, 7518.323350898446, 7117.644117794193, 7136.7145314186855, 7181.06646135999, 7181.210066892742, 7190.640467976685, 4629.722216667011, 4949.6287778416045, 5008.77460514285, 5091.007253585515, 5097.8725531862, 4988.152014157529, 5064.569511591556, 5076.757874642161, 5133.845984620468, 5282.947170528246], "value": 4600.599481560396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.57252293311086, 334.1495892952436, 341.84958618208003, 342.9416999110151, 345.6301757119882, 6701.095352127461, 6727.79816605502, 6753.561018533798, 6810.62541560214, 6816.420604248632, 6422.229332480098, 6475.773347932812, 6634.469242460604, 6675.66621668917, 6737.5620584661965, 4907.11671899058, 4926.45808961014, 4929.186684197103, 4950.0, 4961.032598643266, 4952.405711314647, 4961.05739909416, 4982.651214414992, 4983.978284451697, 4985.975070124644, 4703.811847526094, 4715.292706094079, 4833.806647734086, 4859.125357435661, 4912.435069966946, 4853.927191092136, 4865.708057516543, 4866.951330486685, 4877.170880950247, 4910.533499317559, 4194.182134483777, 4223.113146239293, 4224.619784219404, 4229.429027081366, 4233.0, 6470.870582588322, 6474.546781725281, 6480.351964803482, 6487.513436492235, 6491.350864913518, 5878.941210587882, 5908.113782932552, 5916.497097746696, 5918.585699001072, 5925.822225333247, 6931.202911665173, 7156.749513767045, 7170.390516806077, 7178.4616153788675, 7190.101237345332, 4768.165571025057, 4797.736124513151, 4806.158922188603, 4807.879803004917, 4828.130936431441, 7549.320561149523, 7565.394768418569, 7568.318851303409, 7569.470137090406, 7571.810704732316, 4847.933454639973, 4850.490698476679, 4882.048000639841, 4886.413630364308, 4889.584385327216, 3679.19057807282, 4509.481409637933, 4905.288733133747, 4964.659541923733, 4973.52751488608, 5673.687947162945, 5873.089671100986, 5897.911531327033, 5913.615614985012, 5929.436703513159, 7107.324804143598, 7155.499115061895, 7185.748498802517, 7190.0, 7199.3520583147765, 1634.8610368118605, 1710.9743353849701, 1733.826617338256, 1735.6788994036144, 1741.4079213067619, 1056.0864851903048, 1106.2201148190507, 1124.3197865291545, 1125.6791814332876, 1127.3067063755732, 6660.83347916306, 6677.966610166918, 6708.530402871752, 6711.731530738716, 6738.528303018742, 7401.888971665429, 7418.703251869865, 7419.146798118178, 7424.183339832614, 7430.108386993596, 6699.598024118569, 6710.966445167841, 6721.462283017445, 6721.630310332881, 6724.0, 3791.9431208531896, 3884.3008258513737, 3925.175713100281, 3942.940855887164, 3946.2699400610977, 7747.031621047369, 7757.224277572311, 7763.534187948741, 7766.106897706723, 7786.1435242123325, 7589.316961473494, 7600.9619951900995, 7647.808804779925, 7662.885056724153, 7665.540067595962, 6285.779997700059, 7749.302562769265, 7749.7287594933905, 7771.028621422322, 7782.688692452239, 7082.362587367162, 7374.078240219973, 7391.667374968032, 7399.778006659809, 7413.66638501258, 7168.390686791681, 7202.819929501804, 7219.783406497813, 7239.565626062453, 7249.818754531179, 6174.9691251545255, 7716.074071111502, 7716.884246736416, 7727.729529466442, 7759.456838021284, 4884.48712885142, 4891.5353041461, 4894.535019173173, 4896.2655601660035, 4904.705717656952, 7104.183018952886, 7324.974503569611, 7326.93759404894, 7359.926400735924, 7380.852382952418, 6197.96901015492, 6870.484713646597, 7126.429885609243, 7190.1731300901065, 7215.67529461186, 5778.913316300175, 7190.4966652335925, 7204.459665525212, 7206.89189662145, 7206.927930720625, 7027.543209691354, 7045.542039767399, 7046.682899269443, 7046.823829404306, 7063.894041589278, 6896.965515172392, 6950.721971121098, 7192.100987376578, 7223.0, 7235.312645298688, 6915.688794004182, 6916.3429474199875, 7016.543924644881, 7033.296670332926, 7037.964810175917], "value": 5256.41172326022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.8465222303316, 778.4939789137064, 779.1896427715177, 780.0054929964294, 796.0407708711, 15351.078935263891, 15673.92163039186, 15680.215989200551, 15694.136822474773, 15728.685426291468, 14330.57008289753, 14422.495212667558, 14460.493882714107, 14463.421463141489, 14484.493042743507, 670.7657909446617, 809.2433574607732, 964.2912459342413, 1005.0150852164883, 1011.8684571005759, 986.2455221755328, 994.2692121290845, 1003.4029752297408, 1004.2518323848743, 1006.416278558438, 1044.4412239451894, 1044.791041791641, 1044.8955104489567, 1045.2160879340495, 1045.3309881675734, 763.9388848892075, 846.2045677063571, 859.510079254825, 861.0227391910196, 1025.723054775214, 791.0, 791.4301702773994, 792.5007245435339, 792.7700966719702, 795.1531618825932, 15262.38950441981, 15315.387384504607, 15324.693506129926, 15365.846341536553, 15409.922950385288, 11478.483468243949, 12746.0, 13027.28349940753, 13256.73486530264, 13300.3349832508, 10306.433146176958, 10354.17166626668, 10380.221483388701, 10430.947845260725, 10583.153347732163, 3532.293541291752, 3625.3836847735947, 3632.146445585285, 3638.2359704462096, 3701.68535674468, 82628.58685706533, 84283.0, 84604.15395846024, 84816.15183848144, 84838.15161848364, 9760.609575617038, 10036.849447258297, 10252.0, 10445.268831181744, 10473.057424831803, 23952.760472395403, 23972.52054958926, 23985.760142398703, 24025.0, 24067.27798166058, 7678.961605191938, 7727.227277272228, 7739.5743234122665, 7800.414968877243, 8019.438639295194, 4186.769727664947, 4200.516940551875, 4247.341662042389, 4345.3699213613845, 4398.604125628709, 3774.584795672474, 3804.752691075071, 3845.5000849889334, 3852.3065848147044, 3852.8844134676006, 664.4883439751364, 675.0144788608686, 677.7526202935992, 687.0484379134834, 703.9331263529956, 554.5425024354923, 575.7581815637442, 590.5954421221477, 609.5763444406184, 629.1726379810534, 6782.762603308861, 8036.598170091589, 8432.53621050848, 8485.915140848636, 8589.48463092204, 536.2760273630646, 586.4633860018035, 590.6721769417928, 607.9604825686316, 611.3122736920964, 3872.8450861965207, 3952.9802350988634, 3995.180987897474, 4038.394240863835, 4110.568390319033, 77974.0, 95501.0, 97433.5128324368, 97491.51254243683, 97882.02117978872, 82764.58617706993, 82772.58613706892, 83224.0, 83518.0, 83988.16011839804, 65579.67210163918, 68399.3160068403, 68463.0, 68704.6564767173, 73816.63091684507, 7813.570253636105, 7831.451798374287, 7964.601769911597, 8062.427826573997, 8379.622916968628, 48104.759476202395, 48179.277310839665, 49188.75405622949, 49948.001039979725, 50332.24501632405, 55151.0, 64844.02733959089, 70217.0, 70588.0, 71491.64254178696, 10264.743381415525, 10446.955304469493, 10631.893681063091, 11113.555457781598, 11913.761724765283, 11823.704407389883, 12041.157119001586, 12069.034477241976, 12447.315397653216, 12867.163634363736, 11268.887311126784, 11444.198906076495, 11614.709632258922, 11730.237534560227, 11730.88556587123, 11518.078553715515, 11694.649160525198, 11695.0, 11820.054395648156, 11834.467448964646, 11325.546978120783, 11594.6521604352, 11623.37824040654, 11804.350760708243, 11827.994620457357, 9505.382150160218, 9953.104220620178, 10118.139958103644, 10271.332363396356, 10340.896591033994, 9903.356281841658, 10057.24570657189, 10095.0, 10146.289759716748, 10160.034796694303], "value": 7123.511105323017, "unit": "score"}], "name": "dromaeo_css", "value": 7576.142732144793, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 122.0, 110.0, 109.0, 112.0, 113.0, 112.0, 113.0, 132.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 119.0, 145.0, 185.0, 150.0, 170.0, 167.0, 99.0, 191.0, 147.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 183.0, 188.0, 182.0, 184.0, 186.0, 198.0, 257.0, 184.0], "value": 192.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 74.0, 177.0, 57.0, 55.0, 57.0, 82.0, 164.0, 62.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 136.0, 80.0, 79.0, 86.0, 125.0, 78.0, 78.0, 157.0], "value": 100.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 84.0, 86.0, 83.0, 86.0, 84.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 92.0, 93.0, 91.0, 101.0, 98.0, 92.0, 92.0, 92.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 82.0, 83.0, 83.0, 85.0, 83.0, 83.0, 85.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 64.0, 62.0, 63.0, 80.0, 58.0, 56.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 62.0, 70.0, 66.0, 69.0, 71.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 93.0, 102.0, 72.0, 82.0, 91.0, 105.0, 104.0, 106.0, 74.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 125.0, 123.0, 123.0, 124.0, 123.0, 147.0, 139.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 212.0, 219.0, 178.0, 165.0, 165.0, 174.0, 222.0, 219.0, 173.0], "value": 188.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 73.0, 97.0, 96.0, 77.0, 67.0, 69.0], "value": 75.0, "unit": "score"}], "name": "kraken", "value": 1523.1000000000004, "alertThreshold": 2.0}]} 23:26:28 INFO - Return code: 0 23:26:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:28 ERROR - # TBPL SUCCESS # 23:26:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:26:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:26:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:26:28 INFO - 2016-07-02 23:26:28.358 screenresolution[1698:15146] starting screenresolution argv=screenresolution get 23:26:28 INFO - 2016-07-02 23:26:28.361 screenresolution[1698:15146] Display 0: 1600x1200x32@60 23:26:28 INFO - 2016-07-02 23:26:28.366 screenresolution[1699:15149] starting screenresolution argv=screenresolution list 23:26:28 INFO - Available Modes on Display 0 23:26:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:26:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:26:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:26:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:26:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:26:28 INFO - Intel Iris: 23:26:28 INFO - Chipset Model: Intel Iris 23:26:28 INFO - Type: GPU 23:26:28 INFO - Bus: Built-In 23:26:28 INFO - VRAM (Dynamic, Max): 1536 MB 23:26:28 INFO - Vendor: Intel (0x8086) 23:26:28 INFO - Device ID: 0x0a2e 23:26:28 INFO - Revision ID: 0x0009 23:26:28 INFO - Displays: 23:26:28 INFO - Display: 23:26:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:26:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:26:28 INFO - Display Serial Number: 1600x1200 60 23:26:28 INFO - Main Display: Yes 23:26:28 INFO - Mirror: Off 23:26:28 INFO - Online: Yes 23:26:28 INFO - Rotation: Supported 23:26:28 INFO - Return code: 0 23:26:28 INFO - Running post-action listener: _resource_record_post_action 23:26:28 INFO - Running post-run listener: _resource_record_post_run 23:26:29 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 32841216; Write bytes: 495853568; Read time: 319; Write time: 1725 23:26:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194789888; Write bytes: 191074304; Read time: 17883; Write time: 367 23:26:29 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 31059456; Write bytes: 300281856; Read time: 299; Write time: 1341 23:26:29 INFO - Running post-run listener: _upload_blobber_files 23:26:29 INFO - Blob upload gear active. 23:26:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:26:30 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:31 INFO - (blobuploader) - INFO - Done attempting. 23:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:32 INFO - (blobuploader) - INFO - Done attempting. 23:26:32 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:32 INFO - Return code: 0 23:26:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e8d7d3e1d1746d4767847d2e039b19c7acd2093928439b28e1d7d88009b32b1b628d31ce0a10552f0782e24855a5a2a0e20b9e4b3b8c736783a0227b4c33ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89b8dc35714177c301cfe7e48de0bff6f4495713cb7416a89a5ba8c206863c4cdbbbd0d3362647d7624be2ef5c085f7e58fb1883573b44b852259a990abdd049"} 23:26:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:32 INFO - Contents: 23:26:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e8d7d3e1d1746d4767847d2e039b19c7acd2093928439b28e1d7d88009b32b1b628d31ce0a10552f0782e24855a5a2a0e20b9e4b3b8c736783a0227b4c33ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89b8dc35714177c301cfe7e48de0bff6f4495713cb7416a89a5ba8c206863c4cdbbbd0d3362647d7624be2ef5c085f7e58fb1883573b44b852259a990abdd049"} 23:26:32 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:32 INFO - Copying logs to upload dir... 23:26:32 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.912327 ========= master_lag: 2.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-02 23:26:34.232492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:34.235697) ========= 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.0GVUlfTJRA/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.V3iedEmBaU/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e8d7d3e1d1746d4767847d2e039b19c7acd2093928439b28e1d7d88009b32b1b628d31ce0a10552f0782e24855a5a2a0e20b9e4b3b8c736783a0227b4c33ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89b8dc35714177c301cfe7e48de0bff6f4495713cb7416a89a5ba8c206863c4cdbbbd0d3362647d7624be2ef5c085f7e58fb1883573b44b852259a990abdd049"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011401 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/87e8d7d3e1d1746d4767847d2e039b19c7acd2093928439b28e1d7d88009b32b1b628d31ce0a10552f0782e24855a5a2a0e20b9e4b3b8c736783a0227b4c33ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/89b8dc35714177c301cfe7e48de0bff6f4495713cb7416a89a5ba8c206863c4cdbbbd0d3362647d7624be2ef5c085f7e58fb1883573b44b852259a990abdd049"}' ========= master_lag: 0.84 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.085558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.085854) ========= 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.0GVUlfTJRA/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.V3iedEmBaU/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.005198 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.135403) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-07-02 23:26:35.135671) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-07-02 23:26:41.159741) ========= ========= Total master_lag: 2.96 =========