builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 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.047626) ========= 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.048095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.048425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.445084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.445482) ========= 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.HDUyNzHInd/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.GbBZSVjzMv/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-07-02 23:05:45 (66.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134513 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.622057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.622353) ========= 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.HDUyNzHInd/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.GbBZSVjzMv/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.022307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.671883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:05:45.672271) ========= 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.HDUyNzHInd/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.GbBZSVjzMv/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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,743 truncating revision to first 12 chars 2016-07-02 23:05:45,743 Setting DEBUG logging. 2016-07-02 23:05:45,743 attempt 1/10 2016-07-02 23:05:45,743 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,131 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:05:47.341614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.341878) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.342283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.342541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:47.360734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-02 23:05:47.361005) ========= /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.HDUyNzHInd/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.GbBZSVjzMv/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-0112', 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": 24, 23:05:49 INFO - "slavename": "t-yosemite-r7-0112", 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:49 INFO - Downloaded 18351376 bytes. 23:05:49 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:49 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:52 INFO - Return code: 0 23:05:52 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:52 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:52 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:52 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:52 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:56 INFO - Return code: 0 23:05:56 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:56 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:56 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:56 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:56 INFO - Downloaded 10840145 bytes. 23:05:56 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:56 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:58 INFO - Downloaded 86193481 bytes. 23:05:58 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:58 INFO - mkdir: /builds/slave/test/properties 23:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:05:58 INFO - Contents: 23:05:58 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:05:58 INFO - Running post-action listener: _resource_record_post_action 23:05:58 INFO - Running post-action listener: set_extra_try_arguments 23:05:58 INFO - ##### 23:05:58 INFO - ##### Running populate-webroot step. 23:05:58 INFO - ##### 23:05:58 INFO - Running pre-action listener: _resource_record_pre_action 23:05:58 INFO - Running main action method: populate_webroot 23:05:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:58 INFO - '--tppagecycles', 23:05:58 INFO - '7'], 23:05:58 INFO - 'tests': ['tsvgm']}}, 23:05:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['damp', 'tps']}, 23:05:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'tests': ['damp', 'tps']}, 23:05:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['dromaeo_dom']}, 23:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['a11yr', 23:05:58 INFO - 'ts_paint', 23:05:58 INFO - 'tpaint', 23:05:58 INFO - 'sessionrestore', 23:05:58 INFO - 'sessionrestore_no_auto_restore', 23:05:58 INFO - 'tabpaint']}, 23:05:58 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:58 INFO - 'ts_paint', 23:05:58 INFO - 'tpaint', 23:05:58 INFO - 'sessionrestore', 23:05:58 INFO - 'sessionrestore_no_auto_restore', 23:05:58 INFO - 'tabpaint']}, 23:05:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:58 INFO - 'ts_paint', 23:05:58 INFO - 'tpaint', 23:05:58 INFO - 'sessionrestore', 23:05:58 INFO - 'sessionrestore_no_auto_restore', 23:05:58 INFO - 'tabpaint']}, 23:05:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:58 INFO - 'ts_paint', 23:05:58 INFO - 'tpaint', 23:05:58 INFO - 'sessionrestore', 23:05:58 INFO - 'sessionrestore_no_auto_restore', 23:05:58 INFO - 'tabpaint']}, 23:05:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['a11yr', 23:05:58 INFO - 'ts_paint', 23:05:58 INFO - 'tpaint', 23:05:58 INFO - 'sessionrestore', 23:05:58 INFO - 'sessionrestore_no_auto_restore', 23:05:58 INFO - 'tabpaint']}, 23:05:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['a11yr', 23:05:58 INFO - 'ts_paint', 23:05:58 INFO - 'tpaint', 23:05:58 INFO - 'sessionrestore', 23:05:58 INFO - 'sessionrestore_no_auto_restore', 23:05:58 INFO - 'tabpaint']}, 23:05:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['tsvgx', 23:05:58 INFO - 'tsvgr_opacity', 23:05:58 INFO - 'tart', 23:05:58 INFO - 'tscrollx', 23:05:58 INFO - 'cart']}, 23:05:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:58 INFO - 'tsvgr_opacity', 23:05:58 INFO - 'tart', 23:05:58 INFO - 'tscrollx', 23:05:58 INFO - 'cart']}, 23:05:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'talos_options': ['--disable-e10s'], 23:05:58 INFO - 'tests': ['tp5o']}, 23:05:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'tests': ['tp5o']}, 23:05:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'talos_options': ['--disable-e10s', 23:05:58 INFO - '--xperf_path', 23:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:58 INFO - 'tests': ['tp5n']}, 23:05:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:58 INFO - 'talos_options': ['--xperf_path', 23:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:58 INFO - 'tests': ['tp5n']}}, 23:05:58 INFO - 'talos.zip': {'path': '', 23:05:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:58 INFO - Running post-action listener: _resource_record_post_action 23:05:58 INFO - ##### 23:05:58 INFO - ##### Running create-virtualenv step. 23:05:58 INFO - ##### 23:05:58 INFO - Running pre-action listener: _resource_record_pre_action 23:05:58 INFO - Running main action method: create_virtualenv 23:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:58 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:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:58 INFO - Using real prefix '/tools/python27' 23:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:05:59 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:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HDUyNzHInd/Render', 23:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:02 INFO - 'HOME': '/Users/cltbld', 23:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:02 INFO - 'LOGNAME': 'cltbld', 23:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:02 INFO - 'MOZ_NO_REMOTE': '1', 23:06:02 INFO - 'NO_EM_RESTART': '1', 23:06:02 INFO - 'PAGER': '/bin/cat', 23:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:02 INFO - 'PWD': '/builds/slave/test', 23:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:02 INFO - 'SHELL': '/bin/bash', 23:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbBZSVjzMv/Listeners', 23:06:02 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:02 INFO - 'USER': 'cltbld', 23:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:02 INFO - 'XPC_FLAGS': '0x0', 23:06:02 INFO - 'XPC_SERVICE_NAME': '0', 23:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:02 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:02 INFO - Cleaning up... 23:06:02 INFO - Return code: 0 23:06:02 INFO - Installing psutil>=0.7.1 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:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HDUyNzHInd/Render', 23:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:02 INFO - 'HOME': '/Users/cltbld', 23:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:02 INFO - 'LOGNAME': 'cltbld', 23:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:02 INFO - 'MOZ_NO_REMOTE': '1', 23:06:02 INFO - 'NO_EM_RESTART': '1', 23:06:02 INFO - 'PAGER': '/bin/cat', 23:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:02 INFO - 'PWD': '/builds/slave/test', 23:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:02 INFO - 'SHELL': '/bin/bash', 23:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbBZSVjzMv/Listeners', 23:06:02 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:02 INFO - 'USER': 'cltbld', 23:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:02 INFO - 'XPC_FLAGS': '0x0', 23:06:02 INFO - 'XPC_SERVICE_NAME': '0', 23:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:02 INFO - Downloading/unpacking psutil>=0.7.1 23:06:02 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:02 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:02 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:02 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:02 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:02 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:07 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:07 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 23:06:07 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:08 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:08 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:08 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:08 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:08 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:08 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 23:06:10 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:11 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:11 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:11 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:11 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:11 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:11 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:11 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:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:14 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:14 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 - 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:14 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:14 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:14 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 23:06:15 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BUL5Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uNAhlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-7uCByG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ZLLsOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:16 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vUxRhX-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-SMZU1n-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pWfIRC-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hiPnGU-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-DO0sCc-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EVx0GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-E1u1Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-N4RKTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9vJ4QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-OWvgjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:17 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hanVDs-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NkxOgN-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-L1B6F_-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:18 INFO - Running setup.py install for mozdebug 23:06:18 INFO - Running setup.py install for mozdevice 23:06:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:18 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:19 INFO - Running setup.py install for mozlog 23:06:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:19 INFO - Running setup.py install for moznetwork 23:06:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:19 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:20 INFO - Running setup.py install for moztest 23:06:20 INFO - Running setup.py install for mozversion 23:06:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:20 INFO - Cleaning up... 23:06:20 INFO - Return code: 0 23:06:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:20 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:20 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:20 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:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HDUyNzHInd/Render', 23:06:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:20 INFO - 'HOME': '/Users/cltbld', 23:06:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:20 INFO - 'LOGNAME': 'cltbld', 23:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:20 INFO - 'MOZ_NO_REMOTE': '1', 23:06:20 INFO - 'NO_EM_RESTART': '1', 23:06:20 INFO - 'PAGER': '/bin/cat', 23:06:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:20 INFO - 'PWD': '/builds/slave/test', 23:06:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:20 INFO - 'SHELL': '/bin/bash', 23:06:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbBZSVjzMv/Listeners', 23:06:20 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:06:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:20 INFO - 'USER': 'cltbld', 23:06:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:20 INFO - 'XPC_FLAGS': '0x0', 23:06:20 INFO - 'XPC_SERVICE_NAME': '0', 23:06:20 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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-i_TRPj-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ObuoDo-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EbCEQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-GuJ3q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vMM3_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-XWKCuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YwxyEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-JE3Vfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vnkQL9-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-z0A6hL-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ybJH2m-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-G17avW-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/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-HtSPKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:22 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2HUxSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:22 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ddo2Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:22 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-bQNqKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:22 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gBHBrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:25 INFO - Installing collected packages: blessings 23:06:25 INFO - Running setup.py install for blessings 23:06:25 INFO - Successfully installed blessings 23:06:25 INFO - Cleaning up... 23:06:25 INFO - Return code: 0 23:06:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:25 INFO - Reading from file tmpfile_stdout 23:06:25 INFO - Current package versions: 23:06:25 INFO - blessings == 1.6 23:06:25 INFO - blobuploader == 1.2.4 23:06:25 INFO - docopt == 0.6.1 23:06:25 INFO - manifestparser == 1.1 23:06:25 INFO - mozInstall == 1.12 23:06:25 INFO - mozcrash == 0.17 23:06:25 INFO - mozdebug == 0.1 23:06:25 INFO - mozdevice == 0.48 23:06:25 INFO - mozfile == 1.2 23:06:25 INFO - mozhttpd == 0.7 23:06:25 INFO - mozinfo == 0.9 23:06:25 INFO - mozleak == 0.1 23:06:25 INFO - mozlog == 3.1 23:06:25 INFO - moznetwork == 0.27 23:06:25 INFO - mozprocess == 0.22 23:06:25 INFO - mozprofile == 0.28 23:06:25 INFO - mozrunner == 6.11 23:06:25 INFO - mozscreenshot == 0.1 23:06:25 INFO - mozsystemmonitor == 0.0 23:06:25 INFO - moztest == 0.7 23:06:25 INFO - mozversion == 1.4 23:06:25 INFO - psutil == 3.1.1 23:06:25 INFO - requests == 1.2.3 23:06:25 INFO - wsgiref == 0.1.2 23:06:25 INFO - Installing None 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', '-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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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', '-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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 23:06:25 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 - 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 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 23:06:25 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:26 INFO - Downloading/unpacking jsonschema 23:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:28 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:28 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:28 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 - 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:28 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:28 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:28 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 - Downloading functools32-3.2.3-2.tar.gz 23:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:29 INFO - warning: no files found matching '*.txt' 23:06:29 INFO - no previously-included directories found matching 'build' 23:06:29 INFO - no previously-included directories found matching 'dist' 23:06:29 INFO - no previously-included directories found matching '.git*' 23:06:29 INFO - Installing collected packages: jsonschema, functools32 23:06:29 INFO - Running setup.py install for functools32 23:06:29 INFO - warning: no files found matching '*.txt' 23:06:29 INFO - no previously-included directories found matching 'build' 23:06:29 INFO - no previously-included directories found matching 'dist' 23:06:29 INFO - no previously-included directories found matching '.git*' 23:06:29 INFO - Successfully installed jsonschema functools32 23:06:29 INFO - Cleaning up... 23:06:29 INFO - Return code: 0 23:06:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103be4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf83d5d9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, '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.HDUyNzHInd/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.GbBZSVjzMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HDUyNzHInd/Render', 23:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:29 INFO - 'HOME': '/Users/cltbld', 23:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:29 INFO - 'LOGNAME': 'cltbld', 23:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:29 INFO - 'MOZ_NO_REMOTE': '1', 23:06:29 INFO - 'NO_EM_RESTART': '1', 23:06:29 INFO - 'PAGER': '/bin/cat', 23:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:29 INFO - 'PWD': '/builds/slave/test', 23:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:29 INFO - 'SHELL': '/bin/bash', 23:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbBZSVjzMv/Listeners', 23:06:29 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:29 INFO - 'USER': 'cltbld', 23:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:29 INFO - 'XPC_FLAGS': '0x0', 23:06:29 INFO - 'XPC_SERVICE_NAME': '0', 23:06:29 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:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (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 - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (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 - 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:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:33 INFO - no previously-included directories found matching 'docs/_build' 23:06:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:33 INFO - Running setup.py install for pep8 23:06:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:33 INFO - no previously-included directories found matching 'docs/_build' 23:06:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:33 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:34 INFO - Reading from file tmpfile_stdout 23:06:34 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:34 INFO - Reading from file tmpfile_stdout 23:06:34 INFO - Output received: 23:06:34 INFO - Usage: mozinstall [options] installer 23:06:34 INFO - Options: 23:06:34 INFO - -h, --help show this help message and exit 23:06:34 INFO - -d DEST, --destination=DEST 23:06:34 INFO - Directory to install application into. [default: 23:06:34 INFO - "/builds/slave/test"] 23:06:34 INFO - --app=APP Application being installed. [default: firefox] 23:06:34 INFO - mkdir: /builds/slave/test/build/application 23:06:34 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:34 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:56 INFO - Reading from file tmpfile_stdout 23:06:56 INFO - Output received: 23:06:56 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 23:06:56 INFO - Running post-action listener: _resource_record_post_action 23:06:56 INFO - ##### 23:06:56 INFO - ##### Running run-tests step. 23:06:56 INFO - ##### 23:06:56 INFO - Running pre-action listener: _resource_record_pre_action 23:06:56 INFO - Running main action method: run_tests 23:06:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:06:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:06:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:06:56 INFO - 2016-07-02 23:06:56.045 screenresolution[2240:39415] starting screenresolution argv=screenresolution get 23:06:56 INFO - 2016-07-02 23:06:56.047 screenresolution[2240:39415] Display 0: 1600x1200x32@60 23:06:56 INFO - 2016-07-02 23:06:56.053 screenresolution[2241:39418] starting screenresolution argv=screenresolution list 23:06:56 INFO - Available Modes on Display 0 23:06:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:06:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:06:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:06:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:06:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:06:56 INFO - Intel Iris: 23:06:56 INFO - Chipset Model: Intel Iris 23:06:56 INFO - Type: GPU 23:06:56 INFO - Bus: Built-In 23:06:56 INFO - VRAM (Dynamic, Max): 1536 MB 23:06:56 INFO - Vendor: Intel (0x8086) 23:06:56 INFO - Device ID: 0x0a2e 23:06:56 INFO - Revision ID: 0x0009 23:06:56 INFO - Displays: 23:06:56 INFO - Display: 23:06:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:06:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:06:56 INFO - Display Serial Number: 1600x1200 60 23:06:56 INFO - Main Display: Yes 23:06:56 INFO - Mirror: Off 23:06:56 INFO - Online: Yes 23:06:56 INFO - Rotation: Supported 23:06:56 INFO - Return code: 0 23:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:56 INFO - Python 2.7.3 23:06:56 INFO - Return code: 0 23:06:56 INFO - grabbing minidump binary from tooltool 23:06:56 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:56 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 0x103a83e00>, '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 0x1038ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:56 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:56 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:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:56 INFO - Return code: 0 23:06:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:06:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:06:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:06:57 INFO - Return code: 0 23:06:57 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-0112', '--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:57 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-0112 --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:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HDUyNzHInd/Render', 23:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:57 INFO - 'HOME': '/Users/cltbld', 23:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:57 INFO - 'LOGNAME': 'cltbld', 23:06:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:57 INFO - 'MOZ_NO_REMOTE': '1', 23:06:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:57 INFO - 'NO_EM_RESTART': '1', 23:06:57 INFO - 'PAGER': '/bin/cat', 23:06:57 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:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:57 INFO - 'PWD': '/builds/slave/test', 23:06:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:57 INFO - 'SHELL': '/bin/bash', 23:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GbBZSVjzMv/Listeners', 23:06:57 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 23:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:57 INFO - 'USER': 'cltbld', 23:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:57 INFO - 'XPC_FLAGS': '0x0', 23:06:57 INFO - 'XPC_SERVICE_NAME': '0', 23:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:57 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-0112', '--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:57 INFO - mozversion application_buildid: 20160701064957 23:06:57 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:57 INFO - mozversion application_display_name: Firefox 23:06:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:57 INFO - mozversion application_name: Firefox 23:06:57 INFO - mozversion application_remotingname: firefox 23:06:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:57 INFO - mozversion application_vendor: Mozilla 23:06:57 INFO - mozversion application_version: 48.0 23:06:57 INFO - mozversion platform_buildid: 20160701064957 23:06:57 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:57 INFO - mozversion platform_version: 48.0 23:06:57 INFO - using testdate: 1467526017 23:06:57 INFO - actual date: 1467526017 23:06:57 INFO - starting webserver on 'localhost:54668' 23:06:57 INFO - SUITE-START | Running 2 tests 23:06:57 INFO - TEST-START | dromaeo_css 23:06:57 INFO - operating with platform_type : mac_ 23:06:57 INFO - Initialising browser for dromaeo_css test... 23:06:57 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpLBluu2/profile http://localhost:54668/getInfo.html) 23:06:59 INFO - PROCESS | 2259 | __metrics Screen width/height:1600/1200 23:06:59 INFO - PROCESS | 2259 | colorDepth:24 23:06:59 INFO - PROCESS | 2259 | Browser inner width/height: 1024/689 23:06:59 INFO - PROCESS | 2259 | __metrics 23:07:00 INFO - PROCESS | 2259 | 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:07:00 ERROR - PROCESS | 2259 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:07:00 INFO - TEST-INFO | 2259: exit 0 23:07:00 INFO - Browser initialized. 23:07:00 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:00 INFO - TEST-INFO | started process 2262 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpLBluu2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:12 INFO - PROCESS | 2262 | RSS: Main: 161746944 23:07:12 INFO - PROCESS | 2262 | 23:08:03 INFO - PROCESS | 2262 | 1467526083830 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:13 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54668/tests/dromaeo/cssquery-ext.html) 23:10:15 INFO - PROCESS | 2262 | RSS: Main: 290779136 23:10:15 INFO - PROCESS | 2262 | 23:13:18 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-ext.html (next: http://localhost:54668/tests/dromaeo/cssquery-jquery.html) 23:13:18 INFO - PROCESS | 2262 | RSS: Main: 309264384 23:13:18 INFO - PROCESS | 2262 | 23:16:20 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54668/tests/dromaeo/cssquery-mootools.html) 23:16:21 INFO - PROCESS | 2262 | RSS: Main: 310718464 23:16:21 INFO - PROCESS | 2262 | 23:19:23 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54668/tests/dromaeo/cssquery-prototype.html) 23:19:23 INFO - PROCESS | 2262 | RSS: Main: 303001600 23:19:23 INFO - PROCESS | 2262 | 23:22:27 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54668/tests/dromaeo/cssquery-yui.html) 23:22:27 INFO - PROCESS | 2262 | RSS: Main: 275009536 23:22:27 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | Cycle 1(1): loaded http://localhost:54668/tests/dromaeo/cssquery-yui.html (next: http://localhost:54668/tests/dromaeo/cssquery-dojo.html) 23:25:30 INFO - PROCESS | 2262 | RSS: Main: 316600320 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | __start_tp_report 23:25:30 INFO - PROCESS | 2262 | _x_x_mozilla_page_load 23:25:30 INFO - PROCESS | 2262 | _x_x_mozilla_page_load_details 23:25:30 INFO - PROCESS | 2262 | |i|pagename|runs| 23:25:30 INFO - PROCESS | 2262 | |0;dojo.html;3495.87764428245;3558;3575.0168703606505;3579.319929213449;3638.145035916559;5880.970595147019;5886.499647529954;5906.511834481929;5908.054711246196;5931.317898441681;5863.296404431474;5915.940840591593;5937.406259374071;5949.553783466246;5949.643021418718;5215.739213039361;5236.214567814839;5242.764075616587;5285.312909321783;5318.574514038887;5279.815206467774;5316.229146773735;5323.547498462635;5326.440723724011;5332.946670533283;5262.4474430184855;5307.38965019022;5309.654872433299;5318.9202161967605;5337.386200586943;5292.735363231843;5312.734363281859;5319.015982043335;5336.252924590561;5354.973225133888;5113.923291150636;5186.533212010937;5240.764165612557;5251.6061295403;5265.526102650741;4782.617390608743;5744;5788.131780232999;5813.47678708914;5846.561507886926;6139.693015349215;6182.165407669952;6187.907181392283;6202.906956395657;6209.565330426872;6177.598456100339;6179.38206179383;6200.472959798422;6242.719077641517;6257.624542527463;5983.970080149615;5999.5800293979;6007.579469437142;6008.549358798064;6030.939690603038;6331.2085989251345;6337.461315788118;6342.778002769973;6345.809625711236;6353.777617783356;6137.775380989496;6146.631202127886;6250.656213908279;6263.968680156661;6270.7805226816845;6233.3143354231;6257.468115210167;6266.467350275187;6268.843278918063;6272.2473303203;6173.351798061229;6225.688715564203;6236.781712640036;6246.843828904313;6264.906026409516;6192.628442293477;6245.437910588069;6254.093156492283;6263.937360626335;6280.7487700491465;4950.6782059166035;4994;5009.89980200394;5021.6735912165595;5050.671706339076;4478.6864919455975;4483.103379324149;4485.775711214426;4505.189065968158;4541.023679908835;6003.009503431972;6011.609245399035;6023.608465449732;6040.124181993587;6046.637201767908;6165.167702360213;6184.474319682788;6221.62670239778;6234.127222188898;6238.906416403757;5946;5998.400159983967;6020.217371741734;6077.817665470043;6086.847828804227;5484.287042684426;5515.062439385314;5516.724163791794;5529.806456773994;5538.446155384429;6354.586951848115;6507.642079685663;6512.674366281667;6518.5111116667385;6542.934570654328;6206.193194884636;6274.717637706223;6288.937110628835;6305.4009869062365;6306.495480361468;6462.838429039311;6511.869762604627;6520.152380190545;6520.869582608416;6528.575642583217;6172.321044684992;6189.566730328834;6194.101855231056;6237.220347456568;6251.499880009679;6137.162486020116;6194.938050619436;6246;6254.374562543891;6283.465905397909;5418.133098704188;6240.906386404298;6258.593191442542;6265.122882796321;6272.435480806749;5164.7934082636275;6121.969390153021;6152.569320147547;6184.288806787277;6209.627422354673;6102;6130.9791012021615;6132;6135.84660383494;6137.294211165595;4767;6245.937540624717;6266.624002559861;6293.496520278458;6316.05259211122;5799.565032622654;5912.556558258062;5920.259967504062;6099.085137229451;6214.9067763984485 23:25:30 INFO - PROCESS | 2262 | |1;ext.html;509.57959683261305;522.9450907654699;557.6263903184865;559.8858272038642;595.2172892646173;28990.710092899066;32712;38193.04517387063;39172.60827391725;39217.627383041596;45074.549254507445;45908.77045614767;45934;46072.53927460725;46346.536534634644;8320.459170153936;9987.50062496876;9989.200863930904;9994.650187243447;9999.250056245774;9058.818823623524;10710.571577136905;11330.830037549444;12060.939695301511;12070.517179312817;11781.410929453536;11879.227850189753;11882;11890.881091189107;11899.524019039229;11803.291802491834;11910.761784764256;11913.927746502814;11938.224015439055;11947.223430476992;11822.881771182265;11940.044796416265;11965.820512692317;11969.94015029928;11979.580714674945;41314;41679.95800104991;41793.373099403536;41801.581984180375;41847.37228941568;3474.739394545419;3602.2435288589427;3848.1534062506485;3883.3980732986433;3942.7240093193486;28883.56674649882;29722.85138574293;29753.25616859596;30252.697473025208;30281.242968925733;2742.7120152383914;2823.350629355239;2851.5294976329087;2865.5988161657383;2892.783041271913;334802;336790;336978;337093.62906370865;337355;37059.62940370562;60142.09786853201;60527.394726053055;60885;60937;36244.637553624656;36370;36379.636203638154;36402;36405.45391819125;16175;16428;16436.917815410845;16437.506874793777;16499.17504124789;12922.741545169043;13146.342682865818;13853.030287879752;14021.369038393093;14091.71816563663;8373.8325233495;8395.454295470774;8399.37004724648;8466.619002144918;8479.830403391898;3470.670286322795;3512.473129030615;3515.771474854126;3517.2437925846066;3548.574171099433;875.0593112404191;1037.1693960160324;1080.5191689698008;1112.360392774158;1181.3502573584494;29601.194071574682;30742.846285768428;30963.0711078668;31494.370112598077;31643;1043.6190790361463;1166.1487114406532;1177.5532620204526;1206.6802297391198;1311.3246677960858;13130.474781008843;13320.600381988555;15298.694026119416;15741.68516629661;15789.921050394674;641158;645373;652108;652297;653773;61582;61988;62083.758324834154;62327.376726232156;62589;1490.046370322994;1592.235726851118;1607.1562429724254;1615.1681883829601;1646.028842982646;29458.410831783673;30420;30441.23896902595;30627.08118756441;31062.689373106885;49220.75389623172;49434.752826235635;49683.254751179484;49756.253656194465;49882.25176622281;412366;413666;414059;414327;415290;24176.032958681455;26931.326716832235;27648.861755691094;27683.44633107367;27686;42612.14775704406;43138;43550.782246088565;43597.910052248946;43647.78176109099;37021.81489092645;37415.43876841795;37420.60094382889;37773.81113094417;37935.24129517449;37001.814990924875;37146.07134821651;37368.5052597893;37650.62349376471;37666.24667506689;36656.81671591625;37594.87215383543;38119.42820857745;38132.856014319615;38230;31783;32762.50856237206;33443.83278083594;33475;33619.49570756392;25054.49891002133;25055.12307069244;25058.248252552454;25497.61753573661;25591.6161257585 23:25:30 INFO - PROCESS | 2262 | |2;jquery.html;409.17755311823237;413.6876658123117;414.6620504289002;414.9356849688298;421.5910566750253;20782;21444.356669299927;21559.56880862386;21566.676499852514;22635;12336.93831530841;12611.936940315285;14962.775558366633;21729;21771.67342489864;5373.785048598061;5528.640638358494;5614.031606829306;5658.745356458949;5665.660060396369;5508.889822203553;5626.127950167731;5665.660060396369;5672.5178359839465;5682.829515114553;5408.702521361323;5657.490825825675;5664.291963504562;5672.9432705672825;5678.37537870836;5588.0779671354385;5603.495685388335;5639.661620302795;5643.081352340204;5652.265205523277;5456.890862182774;5496.725163741797;5513.338399392099;5518.530924871391;5518.91721624176;26518.86740566304;26897;27167.864160679266;27544.311392215153;27601.309967250778;2161.5784921940226;2605.739426057379;2641.881115349814;2670.1588999465107;2941.1911724275783;9287.396319239228;9617.951910240474;9646;9725.805483890354;9812.65655702047;1769.1066011664027;1779.297177614848;1825.516238196879;1859.7024476083898;1888.5656299051295;110319;115041;116078.41960790227;118176.40911795472;118480.40759796232;9864.358816676893;10287.8683344832;11698.239614425034;11911.880881191251;11978.341191234565;15689;15798;15837.445689401045;15848;15867.920660396625;9266.629334826532;9293.395929264576;9374.062593740571;9403.200727938065;9468.857967130498;9339;9407.764805879771;9410.294227932933;9510;9510.619575217052;4096.672266218696;4757.811406752863;4824.927626085611;4837.903241935212;4880.170371036932;1944.824965753089;2019.8185959164068;2026.8175864172001;2033.5831154613268;2041.9693704594442;874.173905659146;906.8095699902963;922.4327038871046;960.3277705606104;1049.8110340138696;18413.26346946134;20195.394138175878;21345;21699.78300217009;21705;986.3884391677207;1009.0514915978956;1011.8886922438526;1032.5869652139204;1040.7346126737634;11443.713907152222;11646.53413863453;11656.41717914101;11694.94152529249;11744.001759850338;592631;639759.0060248531;652156.9385196981;653871;658619;86259.56870215609;110589;116594;127043;127900.72099279074;1009.4750729620703;1014.2899970020867;1036.5076588620495;1039.5945581223177;1043.968680939573;18992.050397479794;19376.515587110436;19700.113494893052;19930.00349982466;20004.299849505198;53252;53348.73325633347;53486.1977070352;54026.459735402146;55919.602009950075;75951.24048759663;77539.61230194039;77902;78800.60599696965;80596.59701701689;8148.796280093045;8211.548364839991;8248.092709802037;8285.212904774036;8510.446820956618;11888.34614096233;12556.560520382109;12558.497660093859;12891.290978996245;12929.482820687443;10393.740156496147;11146.609868654557;11413.258138220988;11438.256513326607;11452.828207576726;9143.862842057508;9953.71064655119;10974.176936729618;11298.4915678793;11309.377984210947;11150.832737508781;11361.602343917923;11453.08375329955;11556.94221528887;11604.825927611262;7989.201079891965;8092.595370231583;8299.543525106177;8300.252977232078;8486.363522735943;10277.280590358603;10789.352638841694;11162;11219.887801121884;11515.19393642437 23:25:30 INFO - PROCESS | 2262 | |3;mootools.html;1426.5007247463382;1635.4194261037333;1676.4719113479252;1949.5905859769448;2013.8993050347478;8214.21964913333;8781.429207101533;9004.27965762739;9015.188633023026;9022.774430639238;8675.956620216906;8920.330975176856;8932.285417166628;8942.239909607692;8957.596908139132;2518.6599809025774;2548.1463709657287;2549.579319412295;2550.0564791027255;2552.3619095226195;2493.9127130550432;2562.4746926879943;2563.5257477366745;2569.8972041118427;2573.330933957175;2490.439651078511;2530.0765220694407;2545.1473756291666;2549.4518678484214;2553.3616595851036;2488.464980029284;2520.4707011527603;2529.380301826055;2529.8482091074593;2535.264773215765;2474.319562120413;2506.724260331362;2518.0305582350743;2518.735532769051;2531.1267612673782;8738.606762695694;8967;9017.729468115967;9029.503377314246;9058.456492610465;5508.586855985817;5656.321241451011;5663.178839068312;5663.745131469093;5722.799702010451;3109.54911537828;3614.620464851179;3665.3402387570227;3727.422249551324;3740.8129593520216;1046.9267151299412;1073.4686330266568;1078.9190810689229;1081.4049277315974;1088.7495875948498;12020.45907934145;12173.452194651261;12340.568080117242;12341.444634991536;12353.876461235452;4078.57174996627;4713.010267843792;4714.528547145258;4836.879078023007;4846.61227101831;9625.71122866315;9630.422174669542;9631.422114673001;9634.566444510014;9648.035196480296;5513.09034009392;5571.164325351229;5573.359063707644;5574.693391863405;5580.693061881554;4629.189891768927;4779.996200797802;5001.299818025479;5140.280360749498;5207.297014903015;3919.1579957419967;4017.8995525112105;4045.453863728359;4046;4124.8143833527565;1227.846519185102;1234.481517762542;1235.5366737473448;1247.214255019332;1247.2725275493326;957.4638202606562;985.7092157813462;1002.2783595811004;1003.247564326755;1010.3028910052041;6005.6997150142315;6123.9387606124255;6133.0800379942475;6157.291911430153;6174.012158054689;456.39527625895823;466.53346653346654;469.65480371926606;474.67247599156474;489.54227797009196;3653.415453527476;4041.535223449282;4091.7954102294766;4118.855840045584;4122.505299364096;10387.220958428148;10613.150947924147;10734.19493537972;11033.83449248262;11183;10393;10523.579056837794;10537.473126343652;10556.524956376981;10559.841602375971;8396.916030839735;8446.366522510714;8495.320374370036;8522.786930326667;8577.571121443903;5006.574441172541;5822.359540450631;5915.70421478933;6093.2078829751845;6117.755289788359;9426.245900328095;9508.572114254737;9602.231821454126;9791.951040244754;9792.167665748491;9682.612695492102;9876.35803672759;10045.598176072876;10078.8488172676;10237.436940968319;7085.362317391459;7292.927070729224;7554.546727196386;7845.9215407845195;7966.522008679266;8492.915070849212;8509.44688595264;8574.442661227;8580.485170889766;8592.785180370542;7453;7550.433717471322;7620.923790762022;7631.1605723369275;7633.931249625168;7188.245234250538;7206.135263768381;7269.927300726925;7362.705491780269;7365.926340736524;7167.426605871414;7262.237465066092;7280.381167600814;7282.344588987016;7326.853462930818;4972.129877271535;5012.072766538202;5029.597632189343;5129.461406552258;5189.247559103985;5026.070177017264;5116.948830511797;5137.229415587692;5205.713685747321;5374.086405311028 23:25:30 INFO - PROCESS | 2262 | |4;prototype.html;295.0455277178329;328.81421996571936;329.81695159186654;338.32841809009113;345.1268291223206;5032.874178145544;6784.830379240515;6806.591604503733;6822.931770682291;6850.931490685091;6721.529492935497;6724.361185687364;6731.105624581441;6738.2251041130285;6761.121054262939;4714.787834547445;4789.185838407479;4813.66304358695;4814.711117332971;4906.950930490685;4326.502452218004;4763.166445871976;4902.97037622098;4914.066327397801;5029.421616514092;3982.4424580558743;4895.069936712031;4896.657233993622;4920.7785649645675;4924;4669.859904202863;4735.195016847144;4866.197077482211;4867.853964381075;4923.679960802554;4165.770882601456;4174.227767862955;4178.937315940263;4178.958210417887;4180.122174343392;6385.4253117219205;6430.196225471816;6443.323451037667;6444.935550644481;6483.286838447767;5877.235959325303;5877.85305367365;5880.7353669085;5883;5885.529157667376;7111.928880711178;7113.181984071846;7119.608421536814;7124.323189297009;7131.964340178266;4352.630026447756;4644.628429725613;4646.651501137429;4659.487456379796;4664.603508701764;7376.336129748348;7532.17146113927;7536.171021187665;7548.396128309777;7562.130355009134;4699.0132072265205;4700.506446823103;4706.694064885772;4708.835190768306;4709.835155769531;4770.689905156154;4778.95221047792;4780.402449693788;4780.689255198401;4781.976090119597;5781.248437703071;5783.074708046776;5786.826395208151;5802.912956305659;5805.970970145122;6875.278095799869;7138.250483699137;7150.177729561167;7162.534435261691;7190;1634.2645809385824;1660.2611837732334;1661.7424299233637;1663.0853030832993;1663.3180396037567;876.8465518534231;894.9552522373855;961.6009356117273;1025.251566356564;1054.6361505280665;5608.411116832755;6618;6788.422984046411;6935.549189302679;6938.861222775517;7514.248575142551;7525.623718814038;7533.698652053857;7539.132999704994;7548.66031028605;6910.896336554955;6944.02783610295;6950.6177160256675;6962.268961758942;6966.164060312693;3483.6936148944146;3566.8751593694615;3935.2719746846924;3970.9801450993136;3984.163325701635;6988.965055174794;7271.381932535794;7885.408594355332;7887.881681774778;7894.973653425133;7612.467127301146;7710.691572337156;7729.5362278262355;7739.729109481141;7742.187070357644;7888.329491993245;7906.9604651977525;7914.327282180964;7915.643796029192;7925.762227133196;7184.1019872515935;7450.925490745023;7482.738104166328;7487.775366739006;7508;6888.896666549906;7368.336849683555;7376.815579610553;7384.224656411215;7387.852242955003;7891.64487598071;7909.090454597795;7911.446198766032;7913.208679132041;7930.365570754441;4231.936520952127;4679.227927391942;4736.905261894812;4747.905041899212;4757.809687612456;7100.218975912749;7108.573485590881;7473.88789168152;7488.475806693479;7502.849943001001;7203.135623725187;7269.200387957215;7273.127224733066;7278.308560686726;7281.162666293444;7240.167380751281;7255.637218139177;7272.090988626422;7273;7274.381677557467;7111.288871112847;7116.288371162842;7117.3238542338395;7120.465965052538;7126.109236345457;6914.170299564084;7205.531640443354;7242.275772422926;7250.20247772734;7276.4178865689555;6762.830929226809;6889.931100688929;6939;6997.650117494207;7096.574205547684 23:25:30 INFO - PROCESS | 2262 | |5;yui.html;678.1556961582828;685.0854109763466;724.2721065329347;759.2635143910406;762.2606072110054;15358.385664573418;15791.684166316667;15792.289346979385;15797.131157786318;15800.288986995583;14328.928355358235;14440.350184241708;14505.808722081152;14511.782323265134;14530;788.1409263902345;800.651716503323;955.2883102088954;962.417737268951;979.5053497983544;982.9115379615833;983.5819776594918;991.6925753016552;993.0764389118117;994;1042.8592140061107;1049.5906596427399;1052.300220353464;1052.7315534538682;1054.1356088007838;829.9128591497896;1019.2457581389792;1035.2753072849036;1036.714903401563;1040.3549799124592;777.3858651665178;778.7079845058104;778.7780482562499;779.8479296537178;787.0869791042363;15211.467598633995;15302.387904483807;15313.770293445607;15322.616934576725;15341.232938353149;12750.171238869443;12926.612201633967;12970.740585188338;13143.211407315592;13455.125416847874;9181.770455738593;9195.586198621078;9502.762430939212;9588.712338629852;9958.25313101513;3567.4470457079196;3572.517710109128;3639.2721455708697;3674.0814796300924;3818.427235914607;82905.17094829035;83524.58237708833;83943;86753;87369.12630873674;9544.236461083097;9690.806183876282;9881.061299176567;9911.355761875455;10468.371897686011;21237;21643.917804109733;21646.56706865854;21664.35006949794;21674.89162554177;7401.148867880155;7497.062867141607;7516.661750221253;7523.849523009619;7811.648475818602;4061.3095773718537;4172.332426811696;4185.455890734185;4258.914821703549;4458.598726114666;3747.0819649186124;3805.7335986481235;3810.48558444612;3811.4282857571584;3824.6366595173413;595.2975488923113;682.3279070115932;688.9069975553236;706.703184662443;719.4172720096739;583.0845572451295;588.1471865794615;628.7893555658814;635.6694518850172;649.04590252329;8002.799930001796;8300.2114799094;8362.49825010489;8426.325893928593;8762.342824288076;581.4534337722528;609.065085094378;613.7544982007144;614.6895817612167;631.2708821311393;3494.4234201357;3851.268259030775;4007.519097708294;4049.311617025113;4056.0983768616593;95250.0474995255;96397;96727.51636241915;97988.51005744925;99149.50425247828;81638.59180704059;82045;83330;84422.31155376858;84784.15215847886;73320;73584.63207683928;73592;73924.26075739173;74782.62608687031;6951.478639102189;7869.3311068559815;7996.760097197093;8164.83670326602;8169.877451838346;38245;48929.5107048925;50657.49342506675;50856.491435085176;50874.74562627163;59299.110513341475;60736.69631651814;62773.49001643217;66701.66649166723;70853.58292834218;10217.642382516577;10285.84571231447;10300.330478518872;10389.116925061455;10496.05535501778;10984.176186786182;11152.16358773079;11201.103911686883;11318.26431281964;11802.468888900192;10373.273870828969;10677.09244714208;10692.1980851438;10845.511951962022;11003.119750419786;10371.325863818827;10472.528736207041;10568.682939511827;10654.57381704723;11215.990560849235;10311.587536498457;10433;10519.789604208027;10579.788404232026;11329.263597866113;9171.495567743837;9274.675386361445;9399.060093990547;9422.57598408087;9548.37935534188;8973.147550982647;9159.725208243763;9209.539523023688;9316.767080823034;9385.859212111687 23:25:30 INFO - PROCESS | 2262 | __end_tp_report 23:25:30 INFO - PROCESS | 2262 | __start_cc_report 23:25:30 INFO - PROCESS | 2262 | _x_x_mozilla_cycle_collect,1107 23:25:30 INFO - PROCESS | 2262 | __end_cc_report 23:25:30 INFO - PROCESS | 2262 | __startTimestamp1467527130537__endTimestamp 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | ------- Summary: start ------- 23:25:30 INFO - PROCESS | 2262 | Number of tests: 6 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | [#0] dojo.html Cycles:165 Average:5825.46 Median:6102.00 stddev:633.37 (10.4%) stddev-sans-first:608.38 23:25:30 INFO - PROCESS | 2262 | Values: 3495.9 3558.0 3575.0 3579.3 3638.1 5881.0 5886.5 5906.5 5908.1 5931.3 5863.3 5915.9 5937.4 5949.6 5949.6 5215.7 5236.2 5242.8 5285.3 5318.6 5279.8 5316.2 5323.5 5326.4 5332.9 5262.4 5307.4 5309.7 5318.9 5337.4 5292.7 5312.7 5319.0 5336.3 5355.0 5113.9 5186.5 5240.8 5251.6 5265.5 4782.6 5744.0 5788.1 5813.5 5846.6 6139.7 6182.2 6187.9 6202.9 6209.6 6177.6 6179.4 6200.5 6242.7 6257.6 5984.0 5999.6 6007.6 6008.5 6030.9 6331.2 6337.5 6342.8 6345.8 6353.8 6137.8 6146.6 6250.7 6264.0 6270.8 6233.3 6257.5 6266.5 6268.8 6272.2 6173.4 6225.7 6236.8 6246.8 6264.9 6192.6 6245.4 6254.1 6263.9 6280.7 4950.7 4994.0 5009.9 5021.7 5050.7 4478.7 4483.1 4485.8 4505.2 4541.0 6003.0 6011.6 6023.6 6040.1 6046.6 6165.2 6184.5 6221.6 6234.1 6238.9 5946.0 5998.4 6020.2 6077.8 6086.8 5484.3 5515.1 5516.7 5529.8 5538.4 6354.6 6507.6 6512.7 6518.5 6542.9 6206.2 6274.7 6288.9 6305.4 6306.5 6462.8 6511.9 6520.2 6520.9 6528.6 6172.3 6189.6 6194.1 6237.2 6251.5 6137.2 6194.9 6246.0 6254.4 6283.5 5418.1 6240.9 6258.6 6265.1 6272.4 5164.8 6122.0 6152.6 6184.3 6209.6 6102.0 6131.0 6132.0 6135.8 6137.3 4767.0 6245.9 6266.6 6293.5 6316.1 5799.6 5912.6 5920.3 6099.1 6214.9 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | [#1] ext.html Cycles:180 Average:60631.80 Median:3472.70 stddev:129695.14 (3734.7%) stddev-sans-first:129980.42 23:25:30 INFO - PROCESS | 2262 | Values: 509.6 522.9 557.6 559.9 595.2 28990.7 32712.0 38193.0 39172.6 39217.6 45074.5 45908.8 45934.0 46072.5 46346.5 8320.5 9987.5 9989.2 9994.7 9999.3 9058.8 10710.6 11330.8 12060.9 12070.5 11781.4 11879.2 11882.0 11890.9 11899.5 11803.3 11910.8 11913.9 11938.2 11947.2 11822.9 11940.0 11965.8 11969.9 11979.6 41314.0 41680.0 41793.4 41801.6 41847.4 3474.7 3602.2 3848.2 3883.4 3942.7 28883.6 29722.9 29753.3 30252.7 30281.2 2742.7 2823.4 2851.5 2865.6 2892.8 334802.0 336790.0 336978.0 337093.6 337355.0 37059.6 60142.1 60527.4 60885.0 60937.0 36244.6 36370.0 36379.6 36402.0 36405.5 16175.0 16428.0 16436.9 16437.5 16499.2 12922.7 13146.3 13853.0 14021.4 14091.7 8373.8 8395.5 8399.4 8466.6 8479.8 3470.7 3512.5 3515.8 3517.2 3548.6 875.1 1037.2 1080.5 1112.4 1181.4 29601.2 30742.8 30963.1 31494.4 31643.0 1043.6 1166.1 1177.6 1206.7 1311.3 13130.5 13320.6 15298.7 15741.7 15789.9 641158.0 645373.0 652108.0 652297.0 653773.0 61582.0 61988.0 62083.8 62327.4 62589.0 1490.0 1592.2 1607.2 1615.2 1646.0 29458.4 30420.0 30441.2 30627.1 31062.7 49220.8 49434.8 49683.3 49756.3 49882.3 412366.0 413666.0 414059.0 414327.0 415290.0 24176.0 26931.3 27648.9 27683.4 27686.0 42612.1 43138.0 43550.8 43597.9 43647.8 37021.8 37415.4 37420.6 37773.8 37935.2 37001.8 37146.1 37368.5 37650.6 37666.2 36656.8 37594.9 38119.4 38132.9 38230.0 31783.0 32762.5 33443.8 33475.0 33619.5 25054.5 25055.1 25058.2 25497.6 25591.6 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | [#2] jquery.html Cycles:180 Average:35812.29 Median:14783.58 stddev:106083.91 (717.6%) stddev-sans-first:106348.19 23:25:30 INFO - PROCESS | 2262 | Values: 409.2 413.7 414.7 414.9 421.6 20782.0 21444.4 21559.6 21566.7 22635.0 12336.9 12611.9 14962.8 21729.0 21771.7 5373.8 5528.6 5614.0 5658.7 5665.7 5508.9 5626.1 5665.7 5672.5 5682.8 5408.7 5657.5 5664.3 5672.9 5678.4 5588.1 5603.5 5639.7 5643.1 5652.3 5456.9 5496.7 5513.3 5518.5 5518.9 26518.9 26897.0 27167.9 27544.3 27601.3 2161.6 2605.7 2641.9 2670.2 2941.2 9287.4 9618.0 9646.0 9725.8 9812.7 1769.1 1779.3 1825.5 1859.7 1888.6 110319.0 115041.0 116078.4 118176.4 118480.4 9864.4 10287.9 11698.2 11911.9 11978.3 15689.0 15798.0 15837.4 15848.0 15867.9 9266.6 9293.4 9374.1 9403.2 9468.9 9339.0 9407.8 9410.3 9510.0 9510.6 4096.7 4757.8 4824.9 4837.9 4880.2 1944.8 2019.8 2026.8 2033.6 2042.0 874.2 906.8 922.4 960.3 1049.8 18413.3 20195.4 21345.0 21699.8 21705.0 986.4 1009.1 1011.9 1032.6 1040.7 11443.7 11646.5 11656.4 11694.9 11744.0 592631.0 639759.0 652156.9 653871.0 658619.0 86259.6 110589.0 116594.0 127043.0 127900.7 1009.5 1014.3 1036.5 1039.6 1044.0 18992.1 19376.5 19700.1 19930.0 20004.3 53252.0 53348.7 53486.2 54026.5 55919.6 75951.2 77539.6 77902.0 78800.6 80596.6 8148.8 8211.5 8248.1 8285.2 8510.4 11888.3 12556.6 12558.5 12891.3 12929.5 10393.7 11146.6 11413.3 11438.3 11452.8 9143.9 9953.7 10974.2 11298.5 11309.4 11150.8 11361.6 11453.1 11556.9 11604.8 7989.2 8092.6 8299.5 8300.3 8486.4 10277.3 10789.4 11162.0 11219.9 11515.2 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | [#3] mootools.html Cycles:180 Average:5802.31 Median:5009.32 stddev:3211.88 (64.1%) stddev-sans-first:3204.06 23:25:30 INFO - PROCESS | 2262 | Values: 1426.5 1635.4 1676.5 1949.6 2013.9 8214.2 8781.4 9004.3 9015.2 9022.8 8676.0 8920.3 8932.3 8942.2 8957.6 2518.7 2548.1 2549.6 2550.1 2552.4 2493.9 2562.5 2563.5 2569.9 2573.3 2490.4 2530.1 2545.1 2549.5 2553.4 2488.5 2520.5 2529.4 2529.8 2535.3 2474.3 2506.7 2518.0 2518.7 2531.1 8738.6 8967.0 9017.7 9029.5 9058.5 5508.6 5656.3 5663.2 5663.7 5722.8 3109.5 3614.6 3665.3 3727.4 3740.8 1046.9 1073.5 1078.9 1081.4 1088.7 12020.5 12173.5 12340.6 12341.4 12353.9 4078.6 4713.0 4714.5 4836.9 4846.6 9625.7 9630.4 9631.4 9634.6 9648.0 5513.1 5571.2 5573.4 5574.7 5580.7 4629.2 4780.0 5001.3 5140.3 5207.3 3919.2 4017.9 4045.5 4046.0 4124.8 1227.8 1234.5 1235.5 1247.2 1247.3 957.5 985.7 1002.3 1003.2 1010.3 6005.7 6123.9 6133.1 6157.3 6174.0 456.4 466.5 469.7 474.7 489.5 3653.4 4041.5 4091.8 4118.9 4122.5 10387.2 10613.2 10734.2 11033.8 11183.0 10393.0 10523.6 10537.5 10556.5 10559.8 8396.9 8446.4 8495.3 8522.8 8577.6 5006.6 5822.4 5915.7 6093.2 6117.8 9426.2 9508.6 9602.2 9792.0 9792.2 9682.6 9876.4 10045.6 10078.8 10237.4 7085.4 7292.9 7554.5 7845.9 7966.5 8492.9 8509.4 8574.4 8580.5 8592.8 7453.0 7550.4 7620.9 7631.2 7633.9 7188.2 7206.1 7269.9 7362.7 7365.9 7167.4 7262.2 7280.4 7282.3 7326.9 4972.1 5012.1 5029.6 5129.5 5189.2 5026.1 5116.9 5137.2 5205.7 5374.1 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | [#4] prototype.html Cycles:180 Average:5882.12 Median:6863.10 stddev:1925.05 (28.0%) stddev-sans-first:1884.22 23:25:30 INFO - PROCESS | 2262 | Values: 295.0 328.8 329.8 338.3 345.1 5032.9 6784.8 6806.6 6822.9 6850.9 6721.5 6724.4 6731.1 6738.2 6761.1 4714.8 4789.2 4813.7 4814.7 4907.0 4326.5 4763.2 4903.0 4914.1 5029.4 3982.4 4895.1 4896.7 4920.8 4924.0 4669.9 4735.2 4866.2 4867.9 4923.7 4165.8 4174.2 4178.9 4179.0 4180.1 6385.4 6430.2 6443.3 6444.9 6483.3 5877.2 5877.9 5880.7 5883.0 5885.5 7111.9 7113.2 7119.6 7124.3 7132.0 4352.6 4644.6 4646.7 4659.5 4664.6 7376.3 7532.2 7536.2 7548.4 7562.1 4699.0 4700.5 4706.7 4708.8 4709.8 4770.7 4779.0 4780.4 4780.7 4782.0 5781.2 5783.1 5786.8 5802.9 5806.0 6875.3 7138.3 7150.2 7162.5 7190.0 1634.3 1660.3 1661.7 1663.1 1663.3 876.8 895.0 961.6 1025.3 1054.6 5608.4 6618.0 6788.4 6935.5 6938.9 7514.2 7525.6 7533.7 7539.1 7548.7 6910.9 6944.0 6950.6 6962.3 6966.2 3483.7 3566.9 3935.3 3971.0 3984.2 6989.0 7271.4 7885.4 7887.9 7895.0 7612.5 7710.7 7729.5 7739.7 7742.2 7888.3 7907.0 7914.3 7915.6 7925.8 7184.1 7450.9 7482.7 7487.8 7508.0 6888.9 7368.3 7376.8 7384.2 7387.9 7891.6 7909.1 7911.4 7913.2 7930.4 4231.9 4679.2 4736.9 4747.9 4757.8 7100.2 7108.6 7473.9 7488.5 7502.8 7203.1 7269.2 7273.1 7278.3 7281.2 7240.2 7255.6 7272.1 7273.0 7274.4 7111.3 7116.3 7117.3 7120.5 7126.1 6914.2 7205.5 7242.3 7250.2 7276.4 6762.8 6889.9 6939.0 6997.7 7096.6 23:25:30 INFO - PROCESS | 2262 | 23:25:30 INFO - PROCESS | 2262 | [#5] yui.html Cycles:180 Average:18595.03 Median:30672.88 stddev:26709.06 (87.1%) stddev-sans-first:26750.10 23:25:30 INFO - PROCESS | 2262 | Values: 678.2 685.1 724.3 759.3 762.3 15358.4 15791.7 15792.3 15797.1 15800.3 14328.9 14440.4 14505.8 14511.8 14530.0 788.1 800.7 955.3 962.4 979.5 982.9 983.6 991.7 993.1 994.0 1042.9 1049.6 1052.3 1052.7 1054.1 829.9 1019.2 1035.3 1036.7 1040.4 777.4 778.7 778.8 779.8 787.1 15211.5 15302.4 15313.8 15322.6 15341.2 12750.2 12926.6 12970.7 13143.2 13455.1 9181.8 9195.6 9502.8 9588.7 9958.3 3567.4 3572.5 3639.3 3674.1 3818.4 82905.2 83524.6 83943.0 86753.0 87369.1 9544.2 9690.8 9881.1 9911.4 10468.4 21237.0 21643.9 21646.6 21664.4 21674.9 7401.1 7497.1 7516.7 7523.8 7811.6 4061.3 4172.3 4185.5 4258.9 4458.6 3747.1 3805.7 3810.5 3811.4 3824.6 595.3 682.3 688.9 706.7 719.4 583.1 588.1 628.8 635.7 649.0 8002.8 8300.2 8362.5 8426.3 8762.3 581.5 609.1 613.8 614.7 631.3 3494.4 3851.3 4007.5 4049.3 4056.1 95250.0 96397.0 96727.5 97988.5 99149.5 81638.6 82045.0 83330.0 84422.3 84784.2 73320.0 73584.6 73592.0 73924.3 74782.6 6951.5 7869.3 7996.8 8164.8 8169.9 38245.0 48929.5 50657.5 50856.5 50874.7 59299.1 60736.7 62773.5 66701.7 70853.6 10217.6 10285.8 10300.3 10389.1 10496.1 10984.2 11152.2 11201.1 11318.3 11802.5 10373.3 10677.1 10692.2 10845.5 11003.1 10371.3 10472.5 10568.7 10654.6 11216.0 10311.6 10433.0 10519.8 10579.8 11329.3 9171.5 9274.7 9399.1 9422.6 9548.4 8973.1 9159.7 9209.5 9316.8 9385.9 23:25:30 INFO - PROCESS | 2262 | -------- Summary: end -------- 23:25:30 INFO - PROCESS | 2262 | 23:25:31 INFO - TEST-INFO | 2262: exit 0 23:25:31 INFO - TEST-OK | dromaeo_css | took 1113386ms 23:25:31 INFO - TEST-START | kraken 23:25:31 INFO - operating with platform_type : mac_ 23:25:31 INFO - Initialising browser for kraken test... 23:25:31 INFO - TEST-INFO | started process 2265 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpGCUYz6/profile http://localhost:54668/getInfo.html) 23:25:33 INFO - PROCESS | 2265 | __metrics Screen width/height:1600/1200 23:25:33 INFO - PROCESS | 2265 | colorDepth:24 23:25:33 INFO - PROCESS | 2265 | Browser inner width/height: 1024/689 23:25:33 INFO - PROCESS | 2265 | __metrics 23:25:33 INFO - PROCESS | 2265 | 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:33 ERROR - PROCESS | 2265 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:25:34 INFO - TEST-INFO | 2265: exit 0 23:25:34 INFO - Browser initialized. 23:25:34 INFO - Running cycle 1/1 for kraken test... 23:25:34 INFO - TEST-INFO | started process 2268 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpGCUYz6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:45 INFO - PROCESS | 2268 | RSS: Main: 161615872 23:25:45 INFO - PROCESS | 2268 | 23:25:48 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:49 INFO - PROCESS | 2268 | RSS: Main: 223821824 23:25:49 INFO - PROCESS | 2268 | 23:25:52 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-dft) 23:25:52 INFO - PROCESS | 2268 | RSS: Main: 239591424 23:25:52 INFO - PROCESS | 2268 | 23:25:55 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-fft) 23:25:56 INFO - PROCESS | 2268 | RSS: Main: 326283264 23:25:56 INFO - PROCESS | 2268 | 23:25:58 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54668/tests/kraken/driver.html?testName=audio-oscillator) 23:25:59 INFO - PROCESS | 2268 | RSS: Main: 230797312 23:25:59 INFO - PROCESS | 2268 | 23:26:01 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:01 INFO - PROCESS | 2268 | RSS: Main: 232759296 23:26:01 INFO - PROCESS | 2268 | 23:26:04 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:05 INFO - PROCESS | 2268 | RSS: Main: 268926976 23:26:05 INFO - PROCESS | 2268 | 23:26:07 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54668/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:08 INFO - PROCESS | 2268 | RSS: Main: 270843904 23:26:08 INFO - PROCESS | 2268 | 23:26:11 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54668/tests/kraken/driver.html?testName=json-parse-financial) 23:26:11 INFO - PROCESS | 2268 | RSS: Main: 267644928 23:26:11 INFO - PROCESS | 2268 | 23:26:13 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:14 INFO - PROCESS | 2268 | RSS: Main: 260710400 23:26:14 INFO - PROCESS | 2268 | 23:26:15 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:16 INFO - PROCESS | 2268 | RSS: Main: 267137024 23:26:16 INFO - PROCESS | 2268 | 23:26:18 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:19 INFO - PROCESS | 2268 | RSS: Main: 271060992 23:26:19 INFO - PROCESS | 2268 | 23:26:21 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:22 INFO - PROCESS | 2268 | RSS: Main: 278224896 23:26:22 INFO - PROCESS | 2268 | 23:26:25 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:26 INFO - PROCESS | 2268 | RSS: Main: 275546112 23:26:26 INFO - PROCESS | 2268 | 23:26:27 INFO - PROCESS | 2268 | Cycle 1(1): loaded http://localhost:54668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54668/tests/kraken/driver.html?testName=ai-astar) 23:26:28 INFO - PROCESS | 2268 | RSS: Main: 336777216 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | __start_tp_report 23:26:28 INFO - PROCESS | 2268 | _x_x_mozilla_page_load 23:26:28 INFO - PROCESS | 2268 | _x_x_mozilla_page_load_details 23:26:28 INFO - PROCESS | 2268 | |i|pagename|runs| 23:26:28 INFO - PROCESS | 2268 | |0;ai-astar;113;113;119;112;113;111;112;113;114;135 23:26:28 INFO - PROCESS | 2268 | |1;audio-beat-detection;158;126;142;175;146;149;142;116;168;117 23:26:28 INFO - PROCESS | 2268 | |2;audio-dft;185;186;184;184;188;184;184;186;187;184 23:26:28 INFO - PROCESS | 2268 | |3;audio-fft;69;78;74;161;56;56;55;67;132;55 23:26:28 INFO - PROCESS | 2268 | |4;audio-oscillator;93;93;145;79;78;80;126;80;77;127 23:26:28 INFO - PROCESS | 2268 | |5;imaging-gaussian-blur;88;85;88;85;86;84;89;85;88;85 23:26:28 INFO - PROCESS | 2268 | |6;imaging-darkroom;91;93;93;93;92;92;92;97;93;92 23:26:28 INFO - PROCESS | 2268 | |7;imaging-desaturate;83;84;84;86;86;83;79;82;84;87 23:26:28 INFO - PROCESS | 2268 | |8;json-parse-financial;59;62;63;63;62;64;63;78;59;56 23:26:28 INFO - PROCESS | 2268 | |9;json-stringify-tinderbox;64;62;70;71;73;70;67;67;68;69 23:26:28 INFO - PROCESS | 2268 | |10;stanford-crypto-aes;80;80;80;80;79;79;79;78;80;81 23:26:28 INFO - PROCESS | 2268 | |11;stanford-crypto-ccm;149;140;132;125;124;137;141;121;146;134 23:26:28 INFO - PROCESS | 2268 | |12;stanford-crypto-pbkdf2;166;166;163;162;165;164;162;166;163;163 23:26:28 INFO - PROCESS | 2268 | |13;stanford-crypto-sha256-iterative;66;65;68;68;69;84;94;94;55;63 23:26:28 INFO - PROCESS | 2268 | __end_tp_report 23:26:28 INFO - PROCESS | 2268 | __start_cc_report 23:26:28 INFO - PROCESS | 2268 | _x_x_mozilla_cycle_collect,1924 23:26:28 INFO - PROCESS | 2268 | __end_cc_report 23:26:28 INFO - PROCESS | 2268 | __startTimestamp1467527188060__endTimestamp 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | ------- Summary: start ------- 23:26:28 INFO - PROCESS | 2268 | Number of tests: 14 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#0] ai-astar Cycles:10 Average:115.50 Median:113.00 stddev:7.18 (6.4%) stddev-sans-first:7.56 23:26:28 INFO - PROCESS | 2268 | Values: 113.0 113.0 119.0 112.0 113.0 111.0 112.0 113.0 114.0 135.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:147.50 stddev:20.02 (13.6%) stddev-sans-first:20.57 23:26:28 INFO - PROCESS | 2268 | Values: 158.0 126.0 142.0 175.0 146.0 149.0 142.0 116.0 168.0 117.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:1.48 (0.8%) stddev-sans-first:1.56 23:26:28 INFO - PROCESS | 2268 | Values: 185.0 186.0 184.0 184.0 188.0 184.0 184.0 186.0 187.0 184.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#3] audio-fft Cycles:10 Average:80.30 Median:61.50 stddev:36.51 (59.4%) stddev-sans-first:38.49 23:26:28 INFO - PROCESS | 2268 | Values: 69.0 78.0 74.0 161.0 56.0 56.0 55.0 67.0 132.0 55.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:79.50 stddev:25.24 (31.7%) stddev-sans-first:26.71 23:26:28 INFO - PROCESS | 2268 | Values: 93.0 93.0 145.0 79.0 78.0 80.0 126.0 80.0 77.0 127.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.77 (2.0%) stddev-sans-first:1.76 23:26:28 INFO - PROCESS | 2268 | Values: 88.0 85.0 88.0 85.0 86.0 84.0 89.0 85.0 88.0 85.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:1.62 (1.7%) stddev-sans-first:1.58 23:26:28 INFO - PROCESS | 2268 | Values: 91.0 93.0 93.0 93.0 92.0 92.0 92.0 97.0 93.0 92.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:2.30 (2.7%) stddev-sans-first:2.42 23:26:28 INFO - PROCESS | 2268 | Values: 83.0 84.0 84.0 86.0 86.0 83.0 79.0 82.0 84.0 87.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:5.86 (9.3%) stddev-sans-first:6.04 23:26:28 INFO - PROCESS | 2268 | Values: 59.0 62.0 63.0 63.0 62.0 64.0 63.0 78.0 59.0 56.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:69.50 stddev:3.28 (4.7%) stddev-sans-first:3.13 23:26:28 INFO - PROCESS | 2268 | Values: 64.0 62.0 70.0 71.0 73.0 70.0 67.0 67.0 68.0 69.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:0.84 (1.1%) stddev-sans-first:0.88 23:26:28 INFO - PROCESS | 2268 | Values: 80.0 80.0 80.0 80.0 79.0 79.0 79.0 78.0 80.0 81.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:138.50 stddev:9.48 (6.8%) stddev-sans-first:8.57 23:26:28 INFO - PROCESS | 2268 | Values: 149.0 140.0 132.0 125.0 124.0 137.0 141.0 121.0 146.0 134.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:1.63 (1.0%) stddev-sans-first:1.56 23:26:28 INFO - PROCESS | 2268 | Values: 166.0 166.0 163.0 162.0 165.0 164.0 162.0 166.0 163.0 163.0 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - PROCESS | 2268 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:68.50 stddev:13.35 (19.5%) stddev-sans-first:13.95 23:26:28 INFO - PROCESS | 2268 | Values: 66.0 65.0 68.0 68.0 69.0 84.0 94.0 94.0 55.0 63.0 23:26:28 INFO - PROCESS | 2268 | -------- Summary: end -------- 23:26:28 INFO - PROCESS | 2268 | 23:26:28 INFO - TEST-INFO | 2268: exit 0 23:26:28 INFO - TEST-OK | kraken | took 57801ms 23:26:28 INFO - SUITE-END | took 1171s 23:26:29 INFO - Completed test suite (00:19:31) 23:26:29 INFO - javascript benchmark 23:26:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3495.87764428245, 3558.0, 3575.0168703606505, 3579.319929213449, 3638.145035916559, 5880.970595147019, 5886.499647529954, 5906.511834481929, 5908.054711246196, 5931.317898441681, 5863.296404431474, 5915.940840591593, 5937.406259374071, 5949.553783466246, 5949.643021418718, 5215.739213039361, 5236.214567814839, 5242.764075616587, 5285.312909321783, 5318.574514038887, 5279.815206467774, 5316.229146773735, 5323.547498462635, 5326.440723724011, 5332.946670533283, 5262.4474430184855, 5307.38965019022, 5309.654872433299, 5318.9202161967605, 5337.386200586943, 5292.735363231843, 5312.734363281859, 5319.015982043335, 5336.252924590561, 5354.973225133888, 5113.923291150636, 5186.533212010937, 5240.764165612557, 5251.6061295403, 5265.526102650741, 4782.617390608743, 5744.0, 5788.131780232999, 5813.47678708914, 5846.561507886926, 6139.693015349215, 6182.165407669952, 6187.907181392283, 6202.906956395657, 6209.565330426872, 6177.598456100339, 6179.38206179383, 6200.472959798422, 6242.719077641517, 6257.624542527463, 5983.970080149615, 5999.5800293979, 6007.579469437142, 6008.549358798064, 6030.939690603038, 6331.2085989251345, 6337.461315788118, 6342.778002769973, 6345.809625711236, 6353.777617783356, 6137.775380989496, 6146.631202127886, 6250.656213908279, 6263.968680156661, 6270.7805226816845, 6233.3143354231, 6257.468115210167, 6266.467350275187, 6268.843278918063, 6272.2473303203, 6173.351798061229, 6225.688715564203, 6236.781712640036, 6246.843828904313, 6264.906026409516, 6192.628442293477, 6245.437910588069, 6254.093156492283, 6263.937360626335, 6280.7487700491465, 4950.6782059166035, 4994.0, 5009.89980200394, 5021.6735912165595, 5050.671706339076, 4478.6864919455975, 4483.103379324149, 4485.775711214426, 4505.189065968158, 4541.023679908835, 6003.009503431972, 6011.609245399035, 6023.608465449732, 6040.124181993587, 6046.637201767908, 6165.167702360213, 6184.474319682788, 6221.62670239778, 6234.127222188898, 6238.906416403757, 5946.0, 5998.400159983967, 6020.217371741734, 6077.817665470043, 6086.847828804227, 5484.287042684426, 5515.062439385314, 5516.724163791794, 5529.806456773994, 5538.446155384429, 6354.586951848115, 6507.642079685663, 6512.674366281667, 6518.5111116667385, 6542.934570654328, 6206.193194884636, 6274.717637706223, 6288.937110628835, 6305.4009869062365, 6306.495480361468, 6462.838429039311, 6511.869762604627, 6520.152380190545, 6520.869582608416, 6528.575642583217, 6172.321044684992, 6189.566730328834, 6194.101855231056, 6237.220347456568, 6251.499880009679, 6137.162486020116, 6194.938050619436, 6246.0, 6254.374562543891, 6283.465905397909, 5418.133098704188, 6240.906386404298, 6258.593191442542, 6265.122882796321, 6272.435480806749, 5164.7934082636275, 6121.969390153021, 6152.569320147547, 6184.288806787277, 6209.627422354673, 6102.0, 6130.9791012021615, 6132.0, 6135.84660383494, 6137.294211165595, 4767.0, 6245.937540624717, 6266.624002559861, 6293.496520278458, 6316.05259211122, 5799.565032622654, 5912.556558258062, 5920.259967504062, 6099.085137229451, 6214.9067763984485], "value": 5787.858025683528, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.57959683261305, 522.9450907654699, 557.6263903184865, 559.8858272038642, 595.2172892646173, 28990.710092899066, 32712.0, 38193.04517387063, 39172.60827391725, 39217.627383041596, 45074.549254507445, 45908.77045614767, 45934.0, 46072.53927460725, 46346.536534634644, 8320.459170153936, 9987.50062496876, 9989.200863930904, 9994.650187243447, 9999.250056245774, 9058.818823623524, 10710.571577136905, 11330.830037549444, 12060.939695301511, 12070.517179312817, 11781.410929453536, 11879.227850189753, 11882.0, 11890.881091189107, 11899.524019039229, 11803.291802491834, 11910.761784764256, 11913.927746502814, 11938.224015439055, 11947.223430476992, 11822.881771182265, 11940.044796416265, 11965.820512692317, 11969.94015029928, 11979.580714674945, 41314.0, 41679.95800104991, 41793.373099403536, 41801.581984180375, 41847.37228941568, 3474.739394545419, 3602.2435288589427, 3848.1534062506485, 3883.3980732986433, 3942.7240093193486, 28883.56674649882, 29722.85138574293, 29753.25616859596, 30252.697473025208, 30281.242968925733, 2742.7120152383914, 2823.350629355239, 2851.5294976329087, 2865.5988161657383, 2892.783041271913, 334802.0, 336790.0, 336978.0, 337093.62906370865, 337355.0, 37059.62940370562, 60142.09786853201, 60527.394726053055, 60885.0, 60937.0, 36244.637553624656, 36370.0, 36379.636203638154, 36402.0, 36405.45391819125, 16175.0, 16428.0, 16436.917815410845, 16437.506874793777, 16499.17504124789, 12922.741545169043, 13146.342682865818, 13853.030287879752, 14021.369038393093, 14091.71816563663, 8373.8325233495, 8395.454295470774, 8399.37004724648, 8466.619002144918, 8479.830403391898, 3470.670286322795, 3512.473129030615, 3515.771474854126, 3517.2437925846066, 3548.574171099433, 875.0593112404191, 1037.1693960160324, 1080.5191689698008, 1112.360392774158, 1181.3502573584494, 29601.194071574682, 30742.846285768428, 30963.0711078668, 31494.370112598077, 31643.0, 1043.6190790361463, 1166.1487114406532, 1177.5532620204526, 1206.6802297391198, 1311.3246677960858, 13130.474781008843, 13320.600381988555, 15298.694026119416, 15741.68516629661, 15789.921050394674, 641158.0, 645373.0, 652108.0, 652297.0, 653773.0, 61582.0, 61988.0, 62083.758324834154, 62327.376726232156, 62589.0, 1490.046370322994, 1592.235726851118, 1607.1562429724254, 1615.1681883829601, 1646.028842982646, 29458.410831783673, 30420.0, 30441.23896902595, 30627.08118756441, 31062.689373106885, 49220.75389623172, 49434.752826235635, 49683.254751179484, 49756.253656194465, 49882.25176622281, 412366.0, 413666.0, 414059.0, 414327.0, 415290.0, 24176.032958681455, 26931.326716832235, 27648.861755691094, 27683.44633107367, 27686.0, 42612.14775704406, 43138.0, 43550.782246088565, 43597.910052248946, 43647.78176109099, 37021.81489092645, 37415.43876841795, 37420.60094382889, 37773.81113094417, 37935.24129517449, 37001.814990924875, 37146.07134821651, 37368.5052597893, 37650.62349376471, 37666.24667506689, 36656.81671591625, 37594.87215383543, 38119.42820857745, 38132.856014319615, 38230.0, 31783.0, 32762.50856237206, 33443.83278083594, 33475.0, 33619.49570756392, 25054.49891002133, 25055.12307069244, 25058.248252552454, 25497.61753573661, 25591.6161257585], "value": 19017.66252723416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.17755311823237, 413.6876658123117, 414.6620504289002, 414.9356849688298, 421.5910566750253, 20782.0, 21444.356669299927, 21559.56880862386, 21566.676499852514, 22635.0, 12336.93831530841, 12611.936940315285, 14962.775558366633, 21729.0, 21771.67342489864, 5373.785048598061, 5528.640638358494, 5614.031606829306, 5658.745356458949, 5665.660060396369, 5508.889822203553, 5626.127950167731, 5665.660060396369, 5672.5178359839465, 5682.829515114553, 5408.702521361323, 5657.490825825675, 5664.291963504562, 5672.9432705672825, 5678.37537870836, 5588.0779671354385, 5603.495685388335, 5639.661620302795, 5643.081352340204, 5652.265205523277, 5456.890862182774, 5496.725163741797, 5513.338399392099, 5518.530924871391, 5518.91721624176, 26518.86740566304, 26897.0, 27167.864160679266, 27544.311392215153, 27601.309967250778, 2161.5784921940226, 2605.739426057379, 2641.881115349814, 2670.1588999465107, 2941.1911724275783, 9287.396319239228, 9617.951910240474, 9646.0, 9725.805483890354, 9812.65655702047, 1769.1066011664027, 1779.297177614848, 1825.516238196879, 1859.7024476083898, 1888.5656299051295, 110319.0, 115041.0, 116078.41960790227, 118176.40911795472, 118480.40759796232, 9864.358816676893, 10287.8683344832, 11698.239614425034, 11911.880881191251, 11978.341191234565, 15689.0, 15798.0, 15837.445689401045, 15848.0, 15867.920660396625, 9266.629334826532, 9293.395929264576, 9374.062593740571, 9403.200727938065, 9468.857967130498, 9339.0, 9407.764805879771, 9410.294227932933, 9510.0, 9510.619575217052, 4096.672266218696, 4757.811406752863, 4824.927626085611, 4837.903241935212, 4880.170371036932, 1944.824965753089, 2019.8185959164068, 2026.8175864172001, 2033.5831154613268, 2041.9693704594442, 874.173905659146, 906.8095699902963, 922.4327038871046, 960.3277705606104, 1049.8110340138696, 18413.26346946134, 20195.394138175878, 21345.0, 21699.78300217009, 21705.0, 986.3884391677207, 1009.0514915978956, 1011.8886922438526, 1032.5869652139204, 1040.7346126737634, 11443.713907152222, 11646.53413863453, 11656.41717914101, 11694.94152529249, 11744.001759850338, 592631.0, 639759.0060248531, 652156.9385196981, 653871.0, 658619.0, 86259.56870215609, 110589.0, 116594.0, 127043.0, 127900.72099279074, 1009.4750729620703, 1014.2899970020867, 1036.5076588620495, 1039.5945581223177, 1043.968680939573, 18992.050397479794, 19376.515587110436, 19700.113494893052, 19930.00349982466, 20004.299849505198, 53252.0, 53348.73325633347, 53486.1977070352, 54026.459735402146, 55919.602009950075, 75951.24048759663, 77539.61230194039, 77902.0, 78800.60599696965, 80596.59701701689, 8148.796280093045, 8211.548364839991, 8248.092709802037, 8285.212904774036, 8510.446820956618, 11888.34614096233, 12556.560520382109, 12558.497660093859, 12891.290978996245, 12929.482820687443, 10393.740156496147, 11146.609868654557, 11413.258138220988, 11438.256513326607, 11452.828207576726, 9143.862842057508, 9953.71064655119, 10974.176936729618, 11298.4915678793, 11309.377984210947, 11150.832737508781, 11361.602343917923, 11453.08375329955, 11556.94221528887, 11604.825927611262, 7989.201079891965, 8092.595370231583, 8299.543525106177, 8300.252977232078, 8486.363522735943, 10277.280590358603, 10789.352638841694, 11162.0, 11219.887801121884, 11515.19393642437], "value": 9680.782292284266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.5007247463382, 1635.4194261037333, 1676.4719113479252, 1949.5905859769448, 2013.8993050347478, 8214.21964913333, 8781.429207101533, 9004.27965762739, 9015.188633023026, 9022.774430639238, 8675.956620216906, 8920.330975176856, 8932.285417166628, 8942.239909607692, 8957.596908139132, 2518.6599809025774, 2548.1463709657287, 2549.579319412295, 2550.0564791027255, 2552.3619095226195, 2493.9127130550432, 2562.4746926879943, 2563.5257477366745, 2569.8972041118427, 2573.330933957175, 2490.439651078511, 2530.0765220694407, 2545.1473756291666, 2549.4518678484214, 2553.3616595851036, 2488.464980029284, 2520.4707011527603, 2529.380301826055, 2529.8482091074593, 2535.264773215765, 2474.319562120413, 2506.724260331362, 2518.0305582350743, 2518.735532769051, 2531.1267612673782, 8738.606762695694, 8967.0, 9017.729468115967, 9029.503377314246, 9058.456492610465, 5508.586855985817, 5656.321241451011, 5663.178839068312, 5663.745131469093, 5722.799702010451, 3109.54911537828, 3614.620464851179, 3665.3402387570227, 3727.422249551324, 3740.8129593520216, 1046.9267151299412, 1073.4686330266568, 1078.9190810689229, 1081.4049277315974, 1088.7495875948498, 12020.45907934145, 12173.452194651261, 12340.568080117242, 12341.444634991536, 12353.876461235452, 4078.57174996627, 4713.010267843792, 4714.528547145258, 4836.879078023007, 4846.61227101831, 9625.71122866315, 9630.422174669542, 9631.422114673001, 9634.566444510014, 9648.035196480296, 5513.09034009392, 5571.164325351229, 5573.359063707644, 5574.693391863405, 5580.693061881554, 4629.189891768927, 4779.996200797802, 5001.299818025479, 5140.280360749498, 5207.297014903015, 3919.1579957419967, 4017.8995525112105, 4045.453863728359, 4046.0, 4124.8143833527565, 1227.846519185102, 1234.481517762542, 1235.5366737473448, 1247.214255019332, 1247.2725275493326, 957.4638202606562, 985.7092157813462, 1002.2783595811004, 1003.247564326755, 1010.3028910052041, 6005.6997150142315, 6123.9387606124255, 6133.0800379942475, 6157.291911430153, 6174.012158054689, 456.39527625895823, 466.53346653346654, 469.65480371926606, 474.67247599156474, 489.54227797009196, 3653.415453527476, 4041.535223449282, 4091.7954102294766, 4118.855840045584, 4122.505299364096, 10387.220958428148, 10613.150947924147, 10734.19493537972, 11033.83449248262, 11183.0, 10393.0, 10523.579056837794, 10537.473126343652, 10556.524956376981, 10559.841602375971, 8396.916030839735, 8446.366522510714, 8495.320374370036, 8522.786930326667, 8577.571121443903, 5006.574441172541, 5822.359540450631, 5915.70421478933, 6093.2078829751845, 6117.755289788359, 9426.245900328095, 9508.572114254737, 9602.231821454126, 9791.951040244754, 9792.167665748491, 9682.612695492102, 9876.35803672759, 10045.598176072876, 10078.8488172676, 10237.436940968319, 7085.362317391459, 7292.927070729224, 7554.546727196386, 7845.9215407845195, 7966.522008679266, 8492.915070849212, 8509.44688595264, 8574.442661227, 8580.485170889766, 8592.785180370542, 7453.0, 7550.433717471322, 7620.923790762022, 7631.1605723369275, 7633.931249625168, 7188.245234250538, 7206.135263768381, 7269.927300726925, 7362.705491780269, 7365.926340736524, 7167.426605871414, 7262.237465066092, 7280.381167600814, 7282.344588987016, 7326.853462930818, 4972.129877271535, 5012.072766538202, 5029.597632189343, 5129.461406552258, 5189.247559103985, 5026.070177017264, 5116.948830511797, 5137.229415587692, 5205.713685747321, 5374.086405311028], "value": 4622.751139776499, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.0455277178329, 328.81421996571936, 329.81695159186654, 338.32841809009113, 345.1268291223206, 5032.874178145544, 6784.830379240515, 6806.591604503733, 6822.931770682291, 6850.931490685091, 6721.529492935497, 6724.361185687364, 6731.105624581441, 6738.2251041130285, 6761.121054262939, 4714.787834547445, 4789.185838407479, 4813.66304358695, 4814.711117332971, 4906.950930490685, 4326.502452218004, 4763.166445871976, 4902.97037622098, 4914.066327397801, 5029.421616514092, 3982.4424580558743, 4895.069936712031, 4896.657233993622, 4920.7785649645675, 4924.0, 4669.859904202863, 4735.195016847144, 4866.197077482211, 4867.853964381075, 4923.679960802554, 4165.770882601456, 4174.227767862955, 4178.937315940263, 4178.958210417887, 4180.122174343392, 6385.4253117219205, 6430.196225471816, 6443.323451037667, 6444.935550644481, 6483.286838447767, 5877.235959325303, 5877.85305367365, 5880.7353669085, 5883.0, 5885.529157667376, 7111.928880711178, 7113.181984071846, 7119.608421536814, 7124.323189297009, 7131.964340178266, 4352.630026447756, 4644.628429725613, 4646.651501137429, 4659.487456379796, 4664.603508701764, 7376.336129748348, 7532.17146113927, 7536.171021187665, 7548.396128309777, 7562.130355009134, 4699.0132072265205, 4700.506446823103, 4706.694064885772, 4708.835190768306, 4709.835155769531, 4770.689905156154, 4778.95221047792, 4780.402449693788, 4780.689255198401, 4781.976090119597, 5781.248437703071, 5783.074708046776, 5786.826395208151, 5802.912956305659, 5805.970970145122, 6875.278095799869, 7138.250483699137, 7150.177729561167, 7162.534435261691, 7190.0, 1634.2645809385824, 1660.2611837732334, 1661.7424299233637, 1663.0853030832993, 1663.3180396037567, 876.8465518534231, 894.9552522373855, 961.6009356117273, 1025.251566356564, 1054.6361505280665, 5608.411116832755, 6618.0, 6788.422984046411, 6935.549189302679, 6938.861222775517, 7514.248575142551, 7525.623718814038, 7533.698652053857, 7539.132999704994, 7548.66031028605, 6910.896336554955, 6944.02783610295, 6950.6177160256675, 6962.268961758942, 6966.164060312693, 3483.6936148944146, 3566.8751593694615, 3935.2719746846924, 3970.9801450993136, 3984.163325701635, 6988.965055174794, 7271.381932535794, 7885.408594355332, 7887.881681774778, 7894.973653425133, 7612.467127301146, 7710.691572337156, 7729.5362278262355, 7739.729109481141, 7742.187070357644, 7888.329491993245, 7906.9604651977525, 7914.327282180964, 7915.643796029192, 7925.762227133196, 7184.1019872515935, 7450.925490745023, 7482.738104166328, 7487.775366739006, 7508.0, 6888.896666549906, 7368.336849683555, 7376.815579610553, 7384.224656411215, 7387.852242955003, 7891.64487598071, 7909.090454597795, 7911.446198766032, 7913.208679132041, 7930.365570754441, 4231.936520952127, 4679.227927391942, 4736.905261894812, 4747.905041899212, 4757.809687612456, 7100.218975912749, 7108.573485590881, 7473.88789168152, 7488.475806693479, 7502.849943001001, 7203.135623725187, 7269.200387957215, 7273.127224733066, 7278.308560686726, 7281.162666293444, 7240.167380751281, 7255.637218139177, 7272.090988626422, 7273.0, 7274.381677557467, 7111.288871112847, 7116.288371162842, 7117.3238542338395, 7120.465965052538, 7126.109236345457, 6914.170299564084, 7205.531640443354, 7242.275772422926, 7250.20247772734, 7276.4178865689555, 6762.830929226809, 6889.931100688929, 6939.0, 6997.650117494207, 7096.574205547684], "value": 5223.2356631783005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.1556961582828, 685.0854109763466, 724.2721065329347, 759.2635143910406, 762.2606072110054, 15358.385664573418, 15791.684166316667, 15792.289346979385, 15797.131157786318, 15800.288986995583, 14328.928355358235, 14440.350184241708, 14505.808722081152, 14511.782323265134, 14530.0, 788.1409263902345, 800.651716503323, 955.2883102088954, 962.417737268951, 979.5053497983544, 982.9115379615833, 983.5819776594918, 991.6925753016552, 993.0764389118117, 994.0, 1042.8592140061107, 1049.5906596427399, 1052.300220353464, 1052.7315534538682, 1054.1356088007838, 829.9128591497896, 1019.2457581389792, 1035.2753072849036, 1036.714903401563, 1040.3549799124592, 777.3858651665178, 778.7079845058104, 778.7780482562499, 779.8479296537178, 787.0869791042363, 15211.467598633995, 15302.387904483807, 15313.770293445607, 15322.616934576725, 15341.232938353149, 12750.171238869443, 12926.612201633967, 12970.740585188338, 13143.211407315592, 13455.125416847874, 9181.770455738593, 9195.586198621078, 9502.762430939212, 9588.712338629852, 9958.25313101513, 3567.4470457079196, 3572.517710109128, 3639.2721455708697, 3674.0814796300924, 3818.427235914607, 82905.17094829035, 83524.58237708833, 83943.0, 86753.0, 87369.12630873674, 9544.236461083097, 9690.806183876282, 9881.061299176567, 9911.355761875455, 10468.371897686011, 21237.0, 21643.917804109733, 21646.56706865854, 21664.35006949794, 21674.89162554177, 7401.148867880155, 7497.062867141607, 7516.661750221253, 7523.849523009619, 7811.648475818602, 4061.3095773718537, 4172.332426811696, 4185.455890734185, 4258.914821703549, 4458.598726114666, 3747.0819649186124, 3805.7335986481235, 3810.48558444612, 3811.4282857571584, 3824.6366595173413, 595.2975488923113, 682.3279070115932, 688.9069975553236, 706.703184662443, 719.4172720096739, 583.0845572451295, 588.1471865794615, 628.7893555658814, 635.6694518850172, 649.04590252329, 8002.799930001796, 8300.2114799094, 8362.49825010489, 8426.325893928593, 8762.342824288076, 581.4534337722528, 609.065085094378, 613.7544982007144, 614.6895817612167, 631.2708821311393, 3494.4234201357, 3851.268259030775, 4007.519097708294, 4049.311617025113, 4056.0983768616593, 95250.0474995255, 96397.0, 96727.51636241915, 97988.51005744925, 99149.50425247828, 81638.59180704059, 82045.0, 83330.0, 84422.31155376858, 84784.15215847886, 73320.0, 73584.63207683928, 73592.0, 73924.26075739173, 74782.62608687031, 6951.478639102189, 7869.3311068559815, 7996.760097197093, 8164.83670326602, 8169.877451838346, 38245.0, 48929.5107048925, 50657.49342506675, 50856.491435085176, 50874.74562627163, 59299.110513341475, 60736.69631651814, 62773.49001643217, 66701.66649166723, 70853.58292834218, 10217.642382516577, 10285.84571231447, 10300.330478518872, 10389.116925061455, 10496.05535501778, 10984.176186786182, 11152.16358773079, 11201.103911686883, 11318.26431281964, 11802.468888900192, 10373.273870828969, 10677.09244714208, 10692.1980851438, 10845.511951962022, 11003.119750419786, 10371.325863818827, 10472.528736207041, 10568.682939511827, 10654.57381704723, 11215.990560849235, 10311.587536498457, 10433.0, 10519.789604208027, 10579.788404232026, 11329.263597866113, 9171.495567743837, 9274.675386361445, 9399.060093990547, 9422.57598408087, 9548.37935534188, 8973.147550982647, 9159.725208243763, 9209.539523023688, 9316.767080823034, 9385.859212111687], "value": 7000.021798606272, "unit": "score"}], "name": "dromaeo_css", "value": 7514.960183273354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 119.0, 112.0, 113.0, 111.0, 112.0, 113.0, 114.0, 135.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 142.0, 175.0, 146.0, 149.0, 142.0, 116.0, 168.0, 117.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 184.0, 184.0, 188.0, 184.0, 184.0, 186.0, 187.0, 184.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 78.0, 74.0, 161.0, 56.0, 56.0, 55.0, 67.0, 132.0, 55.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 79.0, 78.0, 80.0, 126.0, 80.0, 77.0, 127.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 86.0, 84.0, 89.0, 85.0, 88.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 93.0, 93.0, 92.0, 92.0, 92.0, 97.0, 93.0, 92.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 86.0, 86.0, 83.0, 79.0, 82.0, 84.0, 87.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 63.0, 63.0, 62.0, 64.0, 63.0, 78.0, 59.0, 56.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 70.0, 71.0, 73.0, 70.0, 67.0, 67.0, 68.0, 69.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 79.0, 79.0, 79.0, 78.0, 80.0, 81.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 140.0, 132.0, 125.0, 124.0, 137.0, 141.0, 121.0, 146.0, 134.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 163.0, 162.0, 165.0, 164.0, 162.0, 166.0, 163.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 68.0, 69.0, 84.0, 94.0, 94.0, 55.0, 63.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1467.6999999999998, "alertThreshold": 2.0}]} 23:26:29 INFO - Return code: 0 23:26:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:29 ERROR - # TBPL SUCCESS # 23:26:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:26:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:26:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:26:29 INFO - 2016-07-02 23:26:29.375 screenresolution[2272:41312] starting screenresolution argv=screenresolution get 23:26:29 INFO - 2016-07-02 23:26:29.377 screenresolution[2272:41312] Display 0: 1600x1200x32@60 23:26:29 INFO - 2016-07-02 23:26:29.383 screenresolution[2273:41315] starting screenresolution argv=screenresolution list 23:26:29 INFO - Available Modes on Display 0 23:26:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:26:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:26:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:26:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:26:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:26:29 INFO - Intel Iris: 23:26:29 INFO - Chipset Model: Intel Iris 23:26:29 INFO - Type: GPU 23:26:29 INFO - Bus: Built-In 23:26:29 INFO - VRAM (Dynamic, Max): 1536 MB 23:26:29 INFO - Vendor: Intel (0x8086) 23:26:29 INFO - Device ID: 0x0a2e 23:26:29 INFO - Revision ID: 0x0009 23:26:29 INFO - Displays: 23:26:29 INFO - Display: 23:26:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:26:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:26:29 INFO - Display Serial Number: 1600x1200 60 23:26:29 INFO - Main Display: Yes 23:26:29 INFO - Mirror: Off 23:26:29 INFO - Online: Yes 23:26:29 INFO - Rotation: Supported 23:26:29 INFO - Return code: 0 23:26:29 INFO - Running post-action listener: _resource_record_post_action 23:26:29 INFO - Running post-run listener: _resource_record_post_run 23:26:30 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 688128; Write bytes: 494056960; Read time: 8; Write time: 1757 23:26:30 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193204736; Write bytes: 184807424; Read time: 17736; Write time: 358 23:26:30 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 688128; Write bytes: 294252032; Read time: 8; Write time: 1341 23:26:30 INFO - Running post-run listener: _upload_blobber_files 23:26:30 INFO - Blob upload gear active. 23:26:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:30 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:30 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:30 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:31 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.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_errorsummary.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 - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:33 INFO - (blobuploader) - INFO - Done attempting. 23:26:33 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:33 INFO - Return code: 0 23:26:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a124d6b0d0cc185b0d015148e509fc99196e37008fc5de5f6bd8ecededd2eb0dec1c786e6534a92d10b4a2898655408010f56babcf8cc130205c1466edd717d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f167e8153b874a818d9181767b6970a30d03b55279bb3dc544665ee3f2e48d63ddfb0ed757974a759cf335786c7dedc3a226816e230a9d49c720f7e90c0c946"} 23:26:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:33 INFO - Contents: 23:26:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a124d6b0d0cc185b0d015148e509fc99196e37008fc5de5f6bd8ecededd2eb0dec1c786e6534a92d10b4a2898655408010f56babcf8cc130205c1466edd717d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f167e8153b874a818d9181767b6970a30d03b55279bb3dc544665ee3f2e48d63ddfb0ed757974a759cf335786c7dedc3a226816e230a9d49c720f7e90c0c946"} 23:26:33 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:33 INFO - Copying logs to upload dir... 23:26:33 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.214175 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-02 23:26:34.199746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:34.203689) ========= 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.HDUyNzHInd/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.GbBZSVjzMv/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/5a124d6b0d0cc185b0d015148e509fc99196e37008fc5de5f6bd8ecededd2eb0dec1c786e6534a92d10b4a2898655408010f56babcf8cc130205c1466edd717d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f167e8153b874a818d9181767b6970a30d03b55279bb3dc544665ee3f2e48d63ddfb0ed757974a759cf335786c7dedc3a226816e230a9d49c720f7e90c0c946"} 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.011327 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/5a124d6b0d0cc185b0d015148e509fc99196e37008fc5de5f6bd8ecededd2eb0dec1c786e6534a92d10b4a2898655408010f56babcf8cc130205c1466edd717d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f167e8153b874a818d9181767b6970a30d03b55279bb3dc544665ee3f2e48d63ddfb0ed757974a759cf335786c7dedc3a226816e230a9d49c720f7e90c0c946"}' ========= master_lag: 0.87 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.082164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.082509) ========= 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.HDUyNzHInd/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.GbBZSVjzMv/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005323 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.133967) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-07-02 23:26:35.134243) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-07-02 23:26:38.127551) ========= ========= Total master_lag: 1.63 =========