builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0236 starttime: 1467525944.94 results: success (0) buildid: 20160701064957 builduid: dc81e5134e46498e86f7107f4128c56e revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:44.943330) ========= 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:44.943724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:44.944004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.331432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.331992) ========= 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.wJpngvwwaB/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.9a2ne7MtEy/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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% 25.8M=0s 2016-07-02 23:05:45 (25.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.494863 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.889298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.889637) ========= 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.wJpngvwwaB/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.9a2ne7MtEy/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.030402 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.941504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:45.941849) ========= 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.wJpngvwwaB/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.9a2ne7MtEy/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-02 23:05:46,025 truncating revision to first 12 chars 2016-07-02 23:05:46,025 Setting DEBUG logging. 2016-07-02 23:05:46,025 attempt 1/10 2016-07-02 23:05:46,025 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:46,502 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.710388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.711092) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.711901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.712524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:05:46.734640) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-02 23:05:46.734919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.wJpngvwwaB/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.9a2ne7MtEy/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:46 INFO - MultiFileLogger online at 20160702 23:05:46 in /builds/slave/test 23:05:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:05:46 INFO - {'append_to_log': False, 23:05:46 INFO - 'base_work_dir': '/builds/slave/test', 23:05:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:05:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:05:46 INFO - 'branch': 'Mozilla-Beta', 23:05:46 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:46 INFO - 'config_files': ('talos/mac_config.py',), 23:05:46 INFO - 'default_actions': ('clobber', 23:05:46 INFO - 'read-buildbot-config', 23:05:46 INFO - 'download-and-extract', 23:05:46 INFO - 'populate-webroot', 23:05:46 INFO - 'create-virtualenv', 23:05:46 INFO - 'install', 23:05:46 INFO - 'run-tests'), 23:05:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:46 INFO - 'download_minidump_stackwalk': True, 23:05:46 INFO - 'download_symbols': 'ondemand', 23:05:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:46 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:46 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:46 INFO - 'installer_path': 'installer.exe', 23:05:46 INFO - 'log_level': 'info', 23:05:46 INFO - 'log_name': 'talos', 23:05:46 INFO - 'log_to_console': True, 23:05:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:05:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:05:46 INFO - 'opt_config_files': (), 23:05:46 INFO - 'pip_index': False, 23:05:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:05:46 INFO - 'cmd': ('bash', 23:05:46 INFO - '-c', 23:05:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:05:46 INFO - 'enabled': True, 23:05:46 INFO - 'halt_on_failure': False, 23:05:46 INFO - 'name': 'check_screen_resolution'},), 23:05:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:05:46 INFO - 'cmd': ('bash', 23:05:46 INFO - '-c', 23:05:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:05:46 INFO - 'enabled': True, 23:05:46 INFO - 'halt_on_failure': False, 23:05:46 INFO - 'name': 'check_screen_resolution'},), 23:05:46 INFO - 'run_cmd_checks_enabled': True, 23:05:46 INFO - 'sps_profile': False, 23:05:46 INFO - 'sps_profile_interval': 0, 23:05:46 INFO - 'suite': 'dromaeojs-e10s', 23:05:46 INFO - 'system_bits': '32', 23:05:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:46 INFO - 'title': 't-yosemite-r7-0236', 23:05:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:46 INFO - 'use_talos_json': True, 23:05:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:05:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:46 INFO - 'work_dir': 'build'} 23:05:46 INFO - ##### 23:05:46 INFO - ##### Running clobber step. 23:05:46 INFO - ##### 23:05:46 INFO - Running pre-action listener: _resource_record_pre_action 23:05:46 INFO - Running main action method: clobber 23:05:46 INFO - rmtree: /builds/slave/test/build 23:05:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:05:48 INFO - Running post-action listener: _resource_record_post_action 23:05:48 INFO - ##### 23:05:48 INFO - ##### Running read-buildbot-config step. 23:05:48 INFO - ##### 23:05:48 INFO - Running pre-action listener: _resource_record_pre_action 23:05:48 INFO - Running main action method: read_buildbot_config 23:05:48 INFO - Using buildbot properties: 23:05:48 INFO - { 23:05:48 INFO - "project": "", 23:05:48 INFO - "product": "firefox", 23:05:48 INFO - "script_repo_revision": "production", 23:05:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 23:05:48 INFO - "repository": "", 23:05:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 23:05:48 INFO - "buildid": "20160701064957", 23:05:48 INFO - "pgo_build": "False", 23:05:48 INFO - "basedir": "/builds/slave/test", 23:05:48 INFO - "buildnumber": 18, 23:05:48 INFO - "slavename": "t-yosemite-r7-0236", 23:05:48 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 23:05:48 INFO - "platform": "yosemite_r7", 23:05:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 23:05:48 INFO - "branch": "mozilla-beta", 23:05:48 INFO - "repo_path": "releases/mozilla-beta", 23:05:48 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:05:48 INFO - "stage_platform": "macosx64", 23:05:48 INFO - "builduid": "dc81e5134e46498e86f7107f4128c56e", 23:05:48 INFO - "slavebuilddir": "test" 23:05:48 INFO - } 23:05:48 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:48 INFO - Running post-action listener: _resource_record_post_action 23:05:48 INFO - ##### 23:05:48 INFO - ##### Running download-and-extract step. 23:05:48 INFO - ##### 23:05:48 INFO - Running pre-action listener: _resource_record_pre_action 23:05:48 INFO - Running main action method: download_and_extract 23:05:48 INFO - mkdir: /builds/slave/test/build/tests 23:05:48 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:48 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:48 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:48 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:52 INFO - Downloaded 18351376 bytes. 23:05:52 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:52 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: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.dmg 23:05:56 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:56 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:06:00 INFO - Downloaded 86193481 bytes. 23:06:00 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:06:00 INFO - mkdir: /builds/slave/test/properties 23:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:06:00 INFO - Writing to file /builds/slave/test/properties/build_url 23:06:00 INFO - Contents: 23:06:00 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg 23:06:00 INFO - Running post-action listener: _resource_record_post_action 23:06:00 INFO - Running post-action listener: set_extra_try_arguments 23:06:00 INFO - ##### 23:06:00 INFO - ##### Running populate-webroot step. 23:06:00 INFO - ##### 23:06:00 INFO - Running pre-action listener: _resource_record_pre_action 23:06:00 INFO - Running main action method: populate_webroot 23:06:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:06:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:06:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:06:00 INFO - '--tppagecycles', 23:06:00 INFO - '7'], 23:06:00 INFO - 'tests': ['tsvgm']}}, 23:06:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:06:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:06:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:06:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:06:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['damp', 'tps']}, 23:06:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'tests': ['damp', 'tps']}, 23:06:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['dromaeo_dom']}, 23:06:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:06:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['a11yr', 23:06:00 INFO - 'ts_paint', 23:06:00 INFO - 'tpaint', 23:06:00 INFO - 'sessionrestore', 23:06:00 INFO - 'sessionrestore_no_auto_restore', 23:06:00 INFO - 'tabpaint']}, 23:06:00 INFO - 'other-e10s': {'tests': ['a11yr', 23:06:00 INFO - 'ts_paint', 23:06:00 INFO - 'tpaint', 23:06:00 INFO - 'sessionrestore', 23:06:00 INFO - 'sessionrestore_no_auto_restore', 23:06:00 INFO - 'tabpaint']}, 23:06:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:06:00 INFO - 'ts_paint', 23:06:00 INFO - 'tpaint', 23:06:00 INFO - 'sessionrestore', 23:06:00 INFO - 'sessionrestore_no_auto_restore', 23:06:00 INFO - 'tabpaint']}, 23:06:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:06:00 INFO - 'ts_paint', 23:06:00 INFO - 'tpaint', 23:06:00 INFO - 'sessionrestore', 23:06:00 INFO - 'sessionrestore_no_auto_restore', 23:06:00 INFO - 'tabpaint']}, 23:06:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['a11yr', 23:06:00 INFO - 'ts_paint', 23:06:00 INFO - 'tpaint', 23:06:00 INFO - 'sessionrestore', 23:06:00 INFO - 'sessionrestore_no_auto_restore', 23:06:00 INFO - 'tabpaint']}, 23:06:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['a11yr', 23:06:00 INFO - 'ts_paint', 23:06:00 INFO - 'tpaint', 23:06:00 INFO - 'sessionrestore', 23:06:00 INFO - 'sessionrestore_no_auto_restore', 23:06:00 INFO - 'tabpaint']}, 23:06:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['tsvgx', 23:06:00 INFO - 'tsvgr_opacity', 23:06:00 INFO - 'tart', 23:06:00 INFO - 'tscrollx', 23:06:00 INFO - 'cart']}, 23:06:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:06:00 INFO - 'tsvgr_opacity', 23:06:00 INFO - 'tart', 23:06:00 INFO - 'tscrollx', 23:06:00 INFO - 'cart']}, 23:06:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'talos_options': ['--disable-e10s'], 23:06:00 INFO - 'tests': ['tp5o']}, 23:06:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'tests': ['tp5o']}, 23:06:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'talos_options': ['--disable-e10s', 23:06:00 INFO - '--xperf_path', 23:06:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:00 INFO - 'tests': ['tp5n']}, 23:06:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:00 INFO - 'talos_options': ['--xperf_path', 23:06:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:00 INFO - 'tests': ['tp5n']}}, 23:06:00 INFO - 'talos.zip': {'path': '', 23:06:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:06:00 INFO - Running post-action listener: _resource_record_post_action 23:06:00 INFO - ##### 23:06:00 INFO - ##### Running create-virtualenv step. 23:06:00 INFO - ##### 23:06:00 INFO - Running pre-action listener: _resource_record_pre_action 23:06:00 INFO - Running main action method: create_virtualenv 23:06:00 INFO - Creating virtualenv /builds/slave/test/build/venv 23:06:00 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:06:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:06:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:06:00 INFO - Using real prefix '/tools/python27' 23:06:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:01 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:04 INFO - Installing pip.................done. 23:06:04 INFO - Return code: 0 23:06:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:04 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:04 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:04 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:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:04 INFO - 'HOME': '/Users/cltbld', 23:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:04 INFO - 'LOGNAME': 'cltbld', 23:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:04 INFO - 'MOZ_NO_REMOTE': '1', 23:06:04 INFO - 'NO_EM_RESTART': '1', 23:06:04 INFO - 'PAGER': '/bin/cat', 23:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:04 INFO - 'PWD': '/builds/slave/test', 23:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:04 INFO - 'SHELL': '/bin/bash', 23:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:04 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:04 INFO - 'USER': 'cltbld', 23:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:04 INFO - 'XPC_FLAGS': '0x0', 23:06:04 INFO - 'XPC_SERVICE_NAME': '0', 23:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:04 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:04 INFO - Cleaning up... 23:06:04 INFO - Return code: 0 23:06:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:04 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:04 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:04 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:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:04 INFO - 'HOME': '/Users/cltbld', 23:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:04 INFO - 'LOGNAME': 'cltbld', 23:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:04 INFO - 'MOZ_NO_REMOTE': '1', 23:06:04 INFO - 'NO_EM_RESTART': '1', 23:06:04 INFO - 'PAGER': '/bin/cat', 23:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:04 INFO - 'PWD': '/builds/slave/test', 23:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:04 INFO - 'SHELL': '/bin/bash', 23:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:04 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:04 INFO - 'USER': 'cltbld', 23:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:04 INFO - 'XPC_FLAGS': '0x0', 23:06:04 INFO - 'XPC_SERVICE_NAME': '0', 23:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:05 INFO - Downloading/unpacking psutil>=0.7.1 23:06:05 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:05 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:05 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:05 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:05 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:05 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:08 INFO - Installing collected packages: psutil 23:06:08 INFO - Running setup.py install for psutil 23:06:08 INFO - building 'psutil._psutil_osx' extension 23:06:08 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:09 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:09 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:09 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:09 INFO - building 'psutil._psutil_posix' extension 23:06:09 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:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:06:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:06:09 INFO - ^ 23:06:09 INFO - 1 warning generated. 23:06:09 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:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:09 INFO - Successfully installed psutil 23:06:09 INFO - Cleaning up... 23:06:10 INFO - Return code: 0 23:06:10 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 23:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 23:06:10 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:10 INFO - 'USER': 'cltbld', 23:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:10 INFO - 'XPC_FLAGS': '0x0', 23:06:10 INFO - 'XPC_SERVICE_NAME': '0', 23:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:12 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:12 INFO - Installing collected packages: mozsystemmonitor 23:06:12 INFO - Running setup.py install for mozsystemmonitor 23:06:13 INFO - Successfully installed mozsystemmonitor 23:06:13 INFO - Cleaning up... 23:06:13 INFO - Return code: 0 23:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:13 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:13 INFO - 'HOME': '/Users/cltbld', 23:06:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:13 INFO - 'LOGNAME': 'cltbld', 23:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:13 INFO - 'MOZ_NO_REMOTE': '1', 23:06:13 INFO - 'NO_EM_RESTART': '1', 23:06:13 INFO - 'PAGER': '/bin/cat', 23:06:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:13 INFO - 'PWD': '/builds/slave/test', 23:06:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:13 INFO - 'SHELL': '/bin/bash', 23:06:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:13 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:13 INFO - 'USER': 'cltbld', 23:06:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:13 INFO - 'XPC_FLAGS': '0x0', 23:06:13 INFO - 'XPC_SERVICE_NAME': '0', 23:06:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:13 INFO - Downloading/unpacking 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:15 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:16 INFO - Downloading docopt-0.6.1.tar.gz 23:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:17 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:17 INFO - Running setup.py install for blobuploader 23:06:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:17 INFO - Running setup.py install for requests 23:06:17 INFO - Running setup.py install for docopt 23:06:17 INFO - Successfully installed blobuploader requests docopt 23:06:17 INFO - Cleaning up... 23:06:17 INFO - Return code: 0 23:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:17 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:17 INFO - 'HOME': '/Users/cltbld', 23:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:17 INFO - 'LOGNAME': 'cltbld', 23:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:17 INFO - 'MOZ_NO_REMOTE': '1', 23:06:17 INFO - 'NO_EM_RESTART': '1', 23:06:17 INFO - 'PAGER': '/bin/cat', 23:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:17 INFO - 'PWD': '/builds/slave/test', 23:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:17 INFO - 'SHELL': '/bin/bash', 23:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:17 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:17 INFO - 'USER': 'cltbld', 23:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:17 INFO - 'XPC_FLAGS': '0x0', 23:06:17 INFO - 'XPC_SERVICE_NAME': '0', 23:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-LWG5Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-kBuGX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-JM7NC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-KSd4dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-F3EMkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-Iw9htB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-G08DYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:18 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-1Uaqwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-NJcgpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-L6IwkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-GEnbQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-CRc5Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-kHD1t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-LYQKlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-rft5O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-oYav9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:19 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-3nVY5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:19 INFO - Running setup.py install for manifestparser 23:06:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Running setup.py install for mozcrash 23:06:20 INFO - Running setup.py install for mozdebug 23:06:20 INFO - Running setup.py install for mozdevice 23:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Running setup.py install for mozfile 23:06:20 INFO - Running setup.py install for mozhttpd 23:06:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Running setup.py install for mozinfo 23:06:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:20 INFO - Running setup.py install for mozInstall 23:06:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozleak 23:06:21 INFO - Running setup.py install for mozlog 23:06:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for moznetwork 23:06:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozprocess 23:06:21 INFO - Running setup.py install for mozprofile 23:06:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:21 INFO - Running setup.py install for mozrunner 23:06:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Running setup.py install for mozscreenshot 23:06:22 INFO - Running setup.py install for moztest 23:06:22 INFO - Running setup.py install for mozversion 23:06:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:22 INFO - Cleaning up... 23:06:22 INFO - Return code: 0 23:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:22 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:22 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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:22 INFO - 'HOME': '/Users/cltbld', 23:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:22 INFO - 'LOGNAME': 'cltbld', 23:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:22 INFO - 'MOZ_NO_REMOTE': '1', 23:06:22 INFO - 'NO_EM_RESTART': '1', 23:06:22 INFO - 'PAGER': '/bin/cat', 23:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:22 INFO - 'PWD': '/builds/slave/test', 23:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:22 INFO - 'SHELL': '/bin/bash', 23:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:22 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:22 INFO - 'USER': 'cltbld', 23:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:22 INFO - 'XPC_FLAGS': '0x0', 23:06:22 INFO - 'XPC_SERVICE_NAME': '0', 23:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:22 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-AQ4IU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:22 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-4iUYWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:22 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-2wn3F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-WDUPV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-IT6GxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-IYjpiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-nF0Rpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-9_lCl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-SWrJeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-IBHw3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-huOTPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:23 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-7dTiSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:24 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-ugH_Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:24 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-6K7Zv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:24 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-sWh_d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:24 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-zD8oUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:24 INFO - Running setup.py (path:/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/pip-AIDplW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:24 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:24 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 - 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:24 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:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:27 INFO - Downloading blessings-1.6.tar.gz 23:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:27 INFO - Installing collected packages: blessings 23:06:27 INFO - Running setup.py install for blessings 23:06:27 INFO - Successfully installed blessings 23:06:27 INFO - Cleaning up... 23:06:27 INFO - Return code: 0 23:06:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:27 INFO - Reading from file tmpfile_stdout 23:06:27 INFO - Current package versions: 23:06:27 INFO - blessings == 1.6 23:06:27 INFO - blobuploader == 1.2.4 23:06:27 INFO - docopt == 0.6.1 23:06:27 INFO - manifestparser == 1.1 23:06:27 INFO - mozInstall == 1.12 23:06:27 INFO - mozcrash == 0.17 23:06:27 INFO - mozdebug == 0.1 23:06:27 INFO - mozdevice == 0.48 23:06:27 INFO - mozfile == 1.2 23:06:27 INFO - mozhttpd == 0.7 23:06:27 INFO - mozinfo == 0.9 23:06:27 INFO - mozleak == 0.1 23:06:27 INFO - mozlog == 3.1 23:06:27 INFO - moznetwork == 0.27 23:06:27 INFO - mozprocess == 0.22 23:06:27 INFO - mozprofile == 0.28 23:06:27 INFO - mozrunner == 6.11 23:06:27 INFO - mozscreenshot == 0.1 23:06:27 INFO - mozsystemmonitor == 0.0 23:06:27 INFO - moztest == 0.7 23:06:27 INFO - mozversion == 1.4 23:06:27 INFO - psutil == 3.1.1 23:06:27 INFO - requests == 1.2.3 23:06:27 INFO - wsgiref == 0.1.2 23:06:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:27 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:27 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:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:27 INFO - 'HOME': '/Users/cltbld', 23:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:27 INFO - 'LOGNAME': 'cltbld', 23:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:27 INFO - 'MOZ_NO_REMOTE': '1', 23:06:27 INFO - 'NO_EM_RESTART': '1', 23:06:27 INFO - 'PAGER': '/bin/cat', 23:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:27 INFO - 'PWD': '/builds/slave/test', 23:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:27 INFO - 'SHELL': '/bin/bash', 23:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:27 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:27 INFO - 'USER': 'cltbld', 23:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:27 INFO - 'XPC_FLAGS': '0x0', 23:06:27 INFO - 'XPC_SERVICE_NAME': '0', 23:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 INFO - Cleaning up... 23:06:27 INFO - Return code: 0 23:06:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:27 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:27 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:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:27 INFO - 'HOME': '/Users/cltbld', 23:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:27 INFO - 'LOGNAME': 'cltbld', 23:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:27 INFO - 'MOZ_NO_REMOTE': '1', 23:06:27 INFO - 'NO_EM_RESTART': '1', 23:06:27 INFO - 'PAGER': '/bin/cat', 23:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:27 INFO - 'PWD': '/builds/slave/test', 23:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:27 INFO - 'SHELL': '/bin/bash', 23:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:27 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:27 INFO - 'USER': 'cltbld', 23:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:27 INFO - 'XPC_FLAGS': '0x0', 23:06:27 INFO - 'XPC_SERVICE_NAME': '0', 23:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:28 INFO - Downloading/unpacking 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:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:30 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:31 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:31 INFO - warning: no files found matching '*.txt' 23:06:31 INFO - no previously-included directories found matching 'build' 23:06:31 INFO - no previously-included directories found matching 'dist' 23:06:31 INFO - no previously-included directories found matching '.git*' 23:06:31 INFO - Installing collected packages: jsonschema, functools32 23:06:31 INFO - Running setup.py install for functools32 23:06:31 INFO - warning: no files found matching '*.txt' 23:06:31 INFO - no previously-included directories found matching 'build' 23:06:31 INFO - no previously-included directories found matching 'dist' 23:06:31 INFO - no previously-included directories found matching '.git*' 23:06:31 INFO - Successfully installed jsonschema functools32 23:06:31 INFO - Cleaning up... 23:06:31 INFO - Return code: 0 23:06:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:31 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 0x110036a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110046420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa289d55ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, '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.wJpngvwwaB/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.9a2ne7MtEy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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:31 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:31 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:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:31 INFO - 'HOME': '/Users/cltbld', 23:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:31 INFO - 'LOGNAME': 'cltbld', 23:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:31 INFO - 'MOZ_NO_REMOTE': '1', 23:06:31 INFO - 'NO_EM_RESTART': '1', 23:06:31 INFO - 'PAGER': '/bin/cat', 23:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:31 INFO - 'PWD': '/builds/slave/test', 23:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:31 INFO - 'SHELL': '/bin/bash', 23:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:31 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:31 INFO - 'USER': 'cltbld', 23:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:31 INFO - 'XPC_FLAGS': '0x0', 23:06:31 INFO - 'XPC_SERVICE_NAME': '0', 23:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:31 INFO - Downloading/unpacking flake8 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:35 INFO - no previously-included directories found matching 'docs/_build' 23:06:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:35 INFO - Running setup.py install for pep8 23:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:35 INFO - no previously-included directories found matching 'docs/_build' 23:06:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:35 INFO - Cleaning up... 23:06:35 INFO - Return code: 0 23:06:35 INFO - Running post-action listener: _resource_record_post_action 23:06:35 INFO - Running post-action listener: _start_resource_monitoring 23:06:35 INFO - Starting resource monitoring. 23:06:35 INFO - ##### 23:06:35 INFO - ##### Running install step. 23:06:35 INFO - ##### 23:06:35 INFO - Running pre-action listener: _resource_record_pre_action 23:06:35 INFO - Running main action method: install 23:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:36 INFO - Reading from file tmpfile_stdout 23:06:36 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:36 INFO - Reading from file tmpfile_stdout 23:06:36 INFO - Output received: 23:06:36 INFO - Usage: mozinstall [options] installer 23:06:36 INFO - Options: 23:06:36 INFO - -h, --help show this help message and exit 23:06:36 INFO - -d DEST, --destination=DEST 23:06:36 INFO - Directory to install application into. [default: 23:06:36 INFO - "/builds/slave/test"] 23:06:36 INFO - --app=APP Application being installed. [default: firefox] 23:06:36 INFO - mkdir: /builds/slave/test/build/application 23:06:36 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:36 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:57 INFO - Reading from file tmpfile_stdout 23:06:57 INFO - Output received: 23:06:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 23:06:57 INFO - Running post-action listener: _resource_record_post_action 23:06:57 INFO - ##### 23:06:57 INFO - ##### Running run-tests step. 23:06:57 INFO - ##### 23:06:57 INFO - Running pre-action listener: _resource_record_pre_action 23:06:57 INFO - Running main action method: run_tests 23:06:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:06:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:06:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:06:57 INFO - 2016-07-02 23:06:57.866 screenresolution[1660:13842] starting screenresolution argv=screenresolution get 23:06:57 INFO - 2016-07-02 23:06:57.869 screenresolution[1660:13842] Display 0: 1600x1200x32@60 23:06:57 INFO - 2016-07-02 23:06:57.875 screenresolution[1661:13844] starting screenresolution argv=screenresolution list 23:06:57 INFO - Available Modes on Display 0 23:06:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:06:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:06:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:06:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:06:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:06:58 INFO - Intel Iris: 23:06:58 INFO - Chipset Model: Intel Iris 23:06:58 INFO - Type: GPU 23:06:58 INFO - Bus: Built-In 23:06:58 INFO - VRAM (Dynamic, Max): 1536 MB 23:06:58 INFO - Vendor: Intel (0x8086) 23:06:58 INFO - Device ID: 0x0a2e 23:06:58 INFO - Revision ID: 0x0009 23:06:58 INFO - Displays: 23:06:58 INFO - Display: 23:06:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:06:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:06:58 INFO - Display Serial Number: 1600x1200 60 23:06:58 INFO - Main Display: Yes 23:06:58 INFO - Mirror: Off 23:06:58 INFO - Online: Yes 23:06:58 INFO - Rotation: Supported 23:06:58 INFO - Return code: 0 23:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:58 INFO - Python 2.7.3 23:06:58 INFO - Return code: 0 23:06:58 INFO - grabbing minidump binary from tooltool 23:06:58 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:58 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 0x10fed5e00>, '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 0x10fd3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fed0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:58 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:58 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:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:58 INFO - Return code: 0 23:06:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:06:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:06:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:06:59 INFO - Return code: 0 23:06:59 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-e10s', '--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-0236', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:06:59 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-e10s --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-0236 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:06:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wJpngvwwaB/Render', 23:06:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:06:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:06:59 INFO - 'HOME': '/Users/cltbld', 23:06:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:06:59 INFO - 'LOGNAME': 'cltbld', 23:06:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:59 INFO - 'MOZ_NO_REMOTE': '1', 23:06:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:59 INFO - 'NO_EM_RESTART': '1', 23:06:59 INFO - 'PAGER': '/bin/cat', 23:06:59 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:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:59 INFO - 'PWD': '/builds/slave/test', 23:06:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:06:59 INFO - 'SHELL': '/bin/bash', 23:06:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9a2ne7MtEy/Listeners', 23:06:59 INFO - 'TMPDIR': '/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/', 23:06:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:06:59 INFO - 'USER': 'cltbld', 23:06:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:06:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:59 INFO - 'XPC_FLAGS': '0x0', 23:06:59 INFO - 'XPC_SERVICE_NAME': '0', 23:06:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:06:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-0236', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:06:59 INFO - mozversion application_buildid: 20160701064957 23:06:59 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:59 INFO - mozversion application_display_name: Firefox 23:06:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:59 INFO - mozversion application_name: Firefox 23:06:59 INFO - mozversion application_remotingname: firefox 23:06:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:59 INFO - mozversion application_vendor: Mozilla 23:06:59 INFO - mozversion application_version: 48.0 23:06:59 INFO - mozversion platform_buildid: 20160701064957 23:06:59 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:59 INFO - mozversion platform_version: 48.0 23:06:59 INFO - using testdate: 1467526019 23:06:59 INFO - actual date: 1467526019 23:06:59 INFO - starting webserver on 'localhost:49271' 23:06:59 INFO - SUITE-START | Running 2 tests 23:06:59 INFO - TEST-START | dromaeo_css 23:06:59 INFO - operating with platform_type : mac_ 23:06:59 INFO - Initialising browser for dromaeo_css test... 23:06:59 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpHoELCQ/profile http://localhost:49271/getInfo.html) 23:07:02 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 23:07:02 INFO - PROCESS | 1679 | colorDepth:24 23:07:02 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 23:07:02 INFO - PROCESS | 1679 | __metrics 23:07:02 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:07:03 INFO - TEST-INFO | 1679: exit 0 23:07:03 INFO - Browser initialized. 23:07:03 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:03 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpHoELCQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:15 INFO - PROCESS | 1684 | RSS: Main: 171192320 23:07:15 INFO - PROCESS | 1684 | 23:08:04 INFO - PROCESS | 1684 | 1467526084937 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:15 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 23:10:16 INFO - PROCESS | 1684 | RSS: Main: 185102336 23:10:16 INFO - PROCESS | 1684 | 23:13:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 23:13:19 INFO - PROCESS | 1684 | RSS: Main: 194875392 23:13:19 INFO - PROCESS | 1684 | 23:16:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 23:16:21 INFO - PROCESS | 1684 | RSS: Main: 196997120 23:16:21 INFO - PROCESS | 1684 | 23:19:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 23:19:23 INFO - PROCESS | 1684 | RSS: Main: 200683520 23:19:23 INFO - PROCESS | 1684 | 23:22:26 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 23:22:27 INFO - PROCESS | 1684 | RSS: Main: 199839744 23:22:27 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 23:25:29 INFO - PROCESS | 1684 | RSS: Main: 204902400 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | __start_tp_report 23:25:29 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 23:25:29 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 23:25:29 INFO - PROCESS | 1684 | |i|pagename|runs| 23:25:29 INFO - PROCESS | 1684 | |0;dojo.html;3655.8903232903012;3663.13916229686;3703.796291203986;3724.646158614932;3736.290104880074;6023.096535519663;6034.456898879105;6048.637081775097;6061.969465190917;6100.359462256466;5919.260092488439;6026.758929642809;6042.758289668408;6079.300880398756;6124.173236613055;5350.224217488462;5363.326979311181;5401.189821526763;5463.235147079412;5472.042392581302;5407.080796264644;5476.2333273341765;5506.669599824003;5524.392316845144;5525.640833345839;5448.782048718046;5465.453454654543;5465.59008074396;5469.07025805614;5478.068728316176;5405.135178371462;5461.5357694596005;5462.972685136589;5465.781368745245;5566.693831839248;4538.319252112209;5348.732563371855;5438.972805135989;5468.644538105011;5490.368607610136;6062.969685151546;6106.297775755756;6117.66352850593;6121.602095863799;6134.8773024539705;6205.658688772116;6335.493160547145;6372.522060845455;6399.93600063998;6470.547061705683;6475.417212450902;6492.350764923517;6497;6502.837429064264;6504.902426463606;5202.843914682566;5240.842774716764;6197.597156184834;6217.595856269328;6225.875482490324;6444.258910225384;6545.934540654533;6603.669816509156;6692.297308782508;6707.3292670732535;6333.524985626096;6353.904691429632;6360.268569114611;6366.299707032223;6372.776952806629;6353.491720662336;6486.383793539606;6495.8700825983215;6504.739810407626;6522.315156908551;6273.780417685359;6334.588251763621;6336.049592561153;6388.201474815648;6394.360563943662;4758.571728544448;5536.557075433956;6146.661933593696;6354;6406.2953075161695;5061.569766569883;5075.492450754969;5080.364954380702;5121.334226550599;5164.1995490699;4610.907781844345;4615.30770384445;4634.328022436795;4644.187267228289;4693.131770622445;6128.601640893327;6153.692315384303;6170.7223174957235;6183.319834818167;6187.535934804908;6289.182406287245;6384.872302553923;6430.356964303533;6543.149390579194;6551.082848401227;6077.969610152009;6134.202553667995;6167.907481387782;6196.504279657616;6204.875902482016;5584.413636568183;5606.131049687224;5697;5715.314162300468;5746.88506229873;6590.3080176581725;6653.401193892573;6756.391924726799;6809.93190068093;6811.284815094443;6506.284308726131;6540.869182616416;6542.771003015062;6546.279909210079;6581.967090164519;6780.96609516969;6781.6948237330425;6796.796096117125;6815.216250131299;6816.522843400914;5438.809641662523;6286.654234017173;6301.464375528131;6339.3343698912795;6441.3880681335195;6450.967745161244;6451.48388128958;6463.838404039937;6479.1901012373455;6491.545591808528;6137.508999280136;6263.561550691408;6296.5592408530965;6299.842503937438;6302.716377763103;5633.6619802811965;5956.017257152521;6206.751729930752;6217.502599792097;6299.685015749286;6138.109974053648;6204.038374052029;6241.843953901007;6253.499720022296;6266.624002559861;6173.382661733791;6255.9374406257175;6307.526935479766;6313.494920406265;6319.905201422074;6172.074188871705;6237.5321850860455;6253.593516421418;6282.937170628235;6291.433770960635 23:25:29 INFO - PROCESS | 1684 | |1;ext.html;519.3637793702712;526.2632314759337;563.9718014099294;598.0938877600436;617.1822335405586;38642.806785966066;39662.20675586486;39676.80161599191;39737;39916;41238.350465981326;41322.38016429756;41929.58070419295;42065.78967105168;42096.36855447171;9600.18398436132;9688.370255933378;9734.26992975526;9744.269179811507;9811.313208075437;9689.418634881895;9831.31180817343;9877.802443951117;9919.950400247988;9934.9503252484;8495.74512764618;9731.172850307732;9880.308378413514;9918.008199180096;9923.603055877757;7723.459357844981;9534;9720.659776907845;9879.555420006118;9926.45404502752;9766.755831104208;9782.755431114208;9787.755306117333;9827.262955278382;9881.209503239723;40062;40270.39594406086;40560.79719601413;40743.59256407428;40807.97980050493;3240.4653232216892;3351.6480769519335;3380.678835510623;3380.881669141568;3427.5886893572683;24404.145854894992;26887.46225075507;27691.584626230622;28479.003234886888;28644.427111457655;2748.945021099587;2766.986165069162;2833.4474777418413;2839.304370429237;2895.6380452443445;411419;415218;416109;421167.9999999969;422186;36749.81625091857;37715.81142094272;49545.75227123914;65261;65986.67006664936;35941.64058359383;36665.08337291589;36682.8165859169;36836.81581592128;36921.44617830735;15994;16295.348186072424;16480.011199328077;16503.587410314838;16528;13896.096753710977;13908;13957.860421395657;13965.930170349084;13972.650683732989;8285.088640249567;8348.831163637096;8350.123237060021;8485.533295668798;8580.742577722678;3565.8573657053425;3589.587197472272;3598.712103031751;3602.819859007039;3613.9638603613625;1024.636254129788;1052.8894466081103;1097.1958340379304;1184.7334349771404;1228.0973484488893;30785.230369240948;30803.537946930814;30976;31310.68689313123;31501;1144.6222746493804;1166.6791632301185;1180.9291442513477;1193.4927655746274;1266.4870727355435;15811.841881581267;15963.44127955516;15985.280662369989;16231.918840405722;16297.511074667778;502021;588175;588331;599542;608120;56878.43121568731;62164.68917655473;62297.06554401688;62316.37683623106;62353;1570.2541292886017;1582.786323846289;1595.5213435969163;1602.8637565807037;1664.0015990405902;25681.871590641927;29821.552676709434;29952.405711314783;30390.544141837447;30755;52154.73922630362;52234.73882630715;52279;52633;52646;527432;536666;539072;544098;544197;26136.215913522625;26754.331141720835;26877.92488300446;27586.310342240802;27956.301092472037;36543.45184822283;38356.80821595874;48396.516034840606;48636.027279453505;48829.2675609859;38149.427758583086;38818.18272421956;39086;39201;39749.403758944216;32252;38862.222755544164;39026.41460378154;39103.608963909996;39279.6072039276;33174.336513270086;38070.2385952285;38644.420333694456;39019.80490097645;39200;31838.522422163223;33825.3234935295;33976.66023339735;34055.82972085124;34102.97691069272;25483.36291592725;25500.74499255058;25585.744142558335;25730;26101.869490653185 23:25:29 INFO - PROCESS | 1684 | |2;jquery.html;413.53477337994747;415.8295099009409;417.5177669791388;423.6060463768694;424.7897290841033;20504.897475512622;21184.682229766568;21245.57508849822;21347.252846150386;22280.554388912253;21561.67657485139;21574;21802.236921707743;21849;22139.00374483148;5475.917861232075;6147.262328520584;6153;6265.843353916143;6272.68636568172;6118.430259291108;6177.938220617803;6187.133801267826;6287.402696743825;6353.809385718436;5302.496262855023;6002.679410529677;6162.4761895238735;6253.7185826637915;6302.653354065525;5736.168255602956;6133.754649814002;6236.594621349621;6269.59247648906;6363.013732871413;4880.487548807395;5776.422357764232;5881.67650779207;5884.117382392633;5896.38088000758;12794.42425090873;13245.602631921058;13375.799363009563;13394.866051339557;13529.932350338284;2035.3181684135832;2073.8237249833783;2229.9108035678555;2347.2254156128606;2855.657840814814;9690.75773105671;10117.696469105938;10156.796864062751;10161.441120738356;10279.229057820694;1748.2657283940775;1766.6643337765784;1833.62410705805;1864.3102052240758;1867.8318951294314;72547.54904901872;75174.12064698426;75409.11477213059;112280.31579526313;118873.81126188714;11655.708607284716;11936.701582460508;12027.759444811054;12194;12226.75546489083;15558.611034724223;15736.685266294839;15824.525264242091;15879;15910.0453972762;9144.085591440802;9233.53832308382;9243.584038718274;9307.72076837696;9495.715128546155;9162.175404213653;9179.0820917909;9326.580303886205;9349.532523373804;9476.810463790685;4109;4803.279508073817;4839.370881785346;4946.802127914915;4968.180250258739;1616.7494038424063;1929.1126082002436;2104.168853302937;2113.9218998310666;2144.292383513437;875.605977310213;943.9952800235955;1000.3847633705365;1055.8416237564272;1059.1156384419096;16137.919310403373;17386.21762020712;17633.7354939676;21913.671294930587;22092.55814883693;948.8671585977969;953.9046095390405;1001.1940387987594;1043.2592859070146;1044.2324891204958;10641.627543036111;11026.558937642565;11452.59915902956;11593.365830341636;11812.40937953099;273671;629983;651550;667628.6618566876;679691;75589.86615200776;105023;121294.78705213011;129220;133394;964.647903515226;1045.9790804183874;1060.9575616975235;1137.2721458266717;1138.3283862521153;16185.67628647444;18656.973866437474;19513;19529.902350488155;20418.795812042285;54535.72732136314;54734.726326368116;55483.612909677584;56598.30205093854;58152.70923645355;81381.59309203416;82391.5880420594;82524.17475825406;82838.17161828304;83985;8459.788505287417;8481.660733570588;8510.914890851012;8623.223909848144;8806.559672016501;10803.351798892092;12473.750524989631;13060.804087938499;13511.527096551574;13554.390052447467;8319.584020799057;9263.425217712871;10872.726727537296;10942.617008404668;11450.255733377304;8681.479111253346;9252.814943700954;9494.620215191315;10626.628068017582;10840.945795270973;11674.883251167379;11734.354610496504;11779.293242405483;11838.28970261787;11972.042236620875;8378.748637540884;8473.491590504344;8584.442011269248;8627.611757471055;8650.697225597074;8584.828303434022;11726.824097638713;11786.705332366759;11880.227785193934;11950.880491194977 23:25:29 INFO - PROCESS | 1684 | |3;mootools.html;1466.3474753734588;1658.0880515716358;1913.2538310059078;2030.7766145723967;2097.6538871086273;7028.367446929776;9046.27629789617;9210.585523651434;9426.151646351827;9460.763480912981;9039.096090390958;9108.998010218887;9189.724308270746;9197.034311397307;9198.63205471782;2497.463045445229;2507.122507122511;2516.8615726135054;2535.695716514021;2551.2473820223076;2515.6603858479148;2571.4471388651436;2584.8319859209187;2586.7154612992554;2589.4950484655405;2534.6958364996135;2567.4094958159635;2597.3506623344165;2599.350162459385;2608.9086881959133;2525.8231923765343;2550.8341957772777;2571.639970404145;2572.176903390916;2588.0682954136496;2161.4056134562966;2499.87500624968;2548.2482667612912;2570.6144078388206;2612.477504499108;8007.119216886138;9313.161815436575;9345.392549484262;9379.296552758571;9393;5703.857403564903;5710.229119068914;5750.913736293959;5859.912101318484;5908.852278693024;3239.967600324014;3672.779633222015;3815.313243616148;3821.9044523887123;3878.8448462061483;980.5587485631495;1071.3893080943865;1095.2990086344746;1096.3257596578126;1097.226455348977;12604.558840440632;12704;12730.299833509152;12741.490340386374;12756.617301481063;5081.974590127025;5085.160948443539;5097.490250974873;5179.637425380262;5238.319018527567;9135.771605709777;10801.945990269998;10806.243562950518;10808.297460665031;10827.512761925733;5705;5828.941710582924;5860.120981852756;5909.468147866713;5910.172575839386;4795.976020119947;5157.406898206679;5199.844004679866;5251.894962100737;5344.518993290622;4247.787610619456;4305.84929527465;4340.283853164193;4385.956140438555;4414.249577571756;1422.4807945100172;1463.129437984419;1466.6846627974824;1479.1125324805246;1485.042147814675;883.4831623500196;889.902110767815;970.0583923468754;983.6655537117415;1012.6759436980243;4910.533499317559;6061.242344706911;6095.878082438415;6169.5064394848305;6213.720382582795;473.60690626780377;483.7411984588299;484.4719256010965;485.8532425746309;486.4381639206722;3992.461017762565;4089.5910408958866;4111.8972025698995;4183.435236243129;4199.727017743837;10870.402127882884;11058.944705276423;11136;11164.05105566036;11185.608503702331;9682.273829462818;10671.146308295318;10834;10842.241043127064;10996.615118470816;8515.063343032261;8587;8649.783755406164;8660.48037117775;8676.219140277279;5968.552358573212;5990.910136347871;5992.820215393545;6043.758249669964;6058.848528786815;9785.461799601091;9846.901530984598;9986.800263994533;10007.549660265451;10089.747756306151;9852.162566181954;10155.086042256233;10163.644272450429;10257.58969641206;10269.870314265574;5999.250093738283;7680.807979800326;7692.230776922263;7855.293023627901;7950.840983180188;8636.352273579632;8673.913260867563;8714;8725.301975842045;8744.519051451976;6391.712372943136;6648.634325112165;7597.696092156252;7715.652795624323;7760.495567788075;7542.2224880860595;7645.541267523967;7650.885236721342;7717.614119294125;7758.68965241384;7308.415326773739;7358.705651773869;7387.8153046174275;7388;7425.183229844821;4382.561743825592;5051.318072060225;5053.797848086036;5160.432352441304;5194.246834209094;5116.565091967075;5117.5394214520875;5167.431582525844;5233.188855727369;5393.730313484231 23:25:29 INFO - PROCESS | 1684 | |4;prototype.html;323.75879969422783;333.6246722437258;342.8599905314828;344.2890431259449;346.321210427562;6301.8656641804455;6818.65906704664;7003.474739394546;7063.717451301948;7101.254368291333;6503.154589903318;6997.055397521333;7019.262977387378;7064.540804847681;7079.221285658574;5083.059633967719;5100.928804950946;5105.18317069269;5106.540411362977;5110.437851836295;5118.744062796864;5121.308623335858;5126.333576635051;5128.794848206067;5143.382794064699;5057.443681195084;5060.367454068241;5064.949350506485;5076.187809950408;5077.695338279696;4043.353063509824;4954.925676114861;4982.60139188864;5049.444561098277;5083.720395378253;4169.97915010426;4211.05251318454;4222.3244280914905;4223.408722778782;4224.2185195738575;5590.301212348457;6376.872462550769;6599.637019963948;6607.669616519155;6657.600543967377;5848.385919478436;5932.139839723259;5938.465538101592;5940;5972.880542389172;6082.905077086123;7306.415486761046;7316.524425912352;7327.0841144856895;7337.523061001018;4559.133764584718;4637.791299391535;4736.360591320196;4736.621070314367;4744.572988431023;6990.825229369256;7855.214478552156;7889.921100788976;7935.444518883681;7952.125266220711;4784.880377990508;4815.3258543803895;4818.084563932842;4819.831305904277;4839.814245509872;4907.067657145202;4931.161702510582;4934.679245849008;4936.259561065869;4937.35814344133;4768.809247630125;5935;5935.821925342247;5951.434613711691;5962.821115366546;7208.387287080552;7430.219826918204;7465.626718664045;7472.103347598323;7522.059742532184;1676.8993860368416;1687.738400547917;1703.097358400025;1704.3779020657619;1712.5975395781982;890.2610833008588;1012.473513772834;1054.4938429553856;1065.9040686338112;1081.2863510083307;7021.508494405445;7022.894656580155;7030.543014704028;7076.0801095857205;7087.539309944837;6558.311377305409;7634.732784352521;7719.961400193076;7736.032995875516;7749.108852481924;7021.578705277598;7057.435405167575;7075;7082.964585177041;7094.751683691046;3250.6424293327714;3952.0910190655736;4065.756054636672;4090.775007374623;4099.692523060782;6469.967650161719;8103.392245581487;8125.553094579855;8140.877886831702;8169.754907352789;7854.253845884632;7981.72063977758;7989.920100799034;7990.720324788605;8024.719134830253;6487.870242595121;8078.3133433658795;8086.999999999883;8141.470804397695;8184.345252379795;6461.709223085067;7449.329560339595;7693.807654808675;7721.575313357819;7753.302202801775;7564.243575642392;7585.848283034419;7589.354904833151;7590.203028681909;7600.3539699126195;7627.351675107678;8105.8784118239455;8107;8120.553369564731;8123.512589244664;4656;4849;4851.56335929768;4857.271409288635;4860.173770459101;7382.815429614303;7627.351675107678;7647.120581133241;7664.846703065796;7670.232976702285;7306.269373062863;7345.338919497271;7372.225916278713;7385.335319821242;7410.888836667562;7398.96300518494;7402.33378995893;7405.44459165554;7415.924690919895;7423.183449820407;5844.707764611838;6932.861342773217;7222.0611320528;7234.16807067194;7240.565566066053;7300.926990730025;7380.594067326134;7381.1511676157925;7392.741254056083;7395.482316237812;7050.753223637148;7251.274872512707;7350.448716346403;7401.111866576045;7401.555906645618 23:25:29 INFO - PROCESS | 1684 | |5;yui.html;703.8873780195169;770.6493545436826;773.4508498965735;779.4894344204545;785.3128512551517;15309.77035344468;15396;15730.056196628211;15748.527544173694;15769.053856768602;14146.78779818301;14282.428702851874;14449.133052016887;14476.638084047903;14489;782.6282515805004;956.741679746468;962.0667952086483;969.0793745941384;975.068809287129;918.6187732091174;955.2405837359281;958.314804914486;963.3786207895903;984.2716389871515;1005.3967619428357;1017.3488967061087;1021.9284650074461;1029.5727273181622;1038.0035166240418;960.8318544254728;1008.742770593494;1010.8483727440906;1017.5065093429681;1029.7785976015155;742.6583771465132;743.7248218159261;749.6963729689485;774.5236679442158;778.1634742651672;14905.925470372687;14922.552323430315;14968.850311496963;14969.476068337664;15293.923530382388;13520.12119212248;13544.255065971367;13594.980376471804;13704.931475342559;13754.65613359664;10374.585016599327;10389.636362727344;10419.687409377731;10461.163106951426;10560;3653.5615726113037;3656.725745569093;3660.432632941898;3692.8892133235777;3728.6457786510236;62755;76949.61525192339;77204.8419273717;78873.81689274666;78960;9708.223342132613;9911.306208565475;10112.292139550307;10165.745856353502;10320.48397580118;22688.319350419515;22752.431189220402;23009.884950575473;23495.530089398115;23624.881875590512;7650.579218142944;7740.496867703581;7813.257740514642;7873.37013038967;7940.007499062617;4169.854055108057;4199.517055538591;4209.074003719177;4220.514640816284;4233.5131459881895;3692.2061756722433;3709.666130048309;3766.6798322142376;3772.320982223171;3773.4339849022867;700.1423256510835;702.8242939265184;706.6961206681176;716.6452605960083;736.9594672292968;525.7108590275333;547.8219578636958;609.2171559545963;624.9406306400884;635.462181520721;8431.114732953074;8636.136386361313;8667.869981950276;8770.824583508294;8888.29242591439;575.1459083261353;578.3695771608966;601.5368166511848;617.4751461257895;619.5167769140078;3902.921941561153;3924.117073658404;4029.8589549365634;4054.7567145971334;4180.665546756252;99597;99686.006279874;100382.49808751055;101374.49312753389;101494.49252753837;84118;85134;85407;85662.71505927417;87554;68143.3185668137;71974.64012679903;72223;72633;72768.27231727615;7889.171636978264;7989.600519974094;8066.878996814935;8136.511809291462;8176.427650064438;51862.22206666828;52948;53173.46826531685;53470;54406.45593544172;71016;72968.17579560554;73000.53998920097;73143;74164;10248.282620216512;10358.792824143324;10376.628785624906;10549.947250264007;10592.152627789605;10895.782084358427;10948.178886583697;11100.666979990614;11437.942810286228;11441.713957150805;10428.009339112772;10518.421486818299;10614.681559553226;10851.914808519401;11383.317000979967;10608;10616.89383106159;10724.624638137628;10748.301360411548;10944.179186560881;10323.741906452398;10429.478526073817;10706.036456718934;10978.286411383235;10984.780304394028;8396.916030839613;9134.406263592846;9170.862437063315;9416.435013899189;9605.663801766905;9113.453192808453;9242;9259.67591134307;9315.534223288943;9332.766680833034 23:25:29 INFO - PROCESS | 1684 | __end_tp_report 23:25:29 INFO - PROCESS | 1684 | __start_cc_report 23:25:29 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,387 23:25:29 INFO - PROCESS | 1684 | __end_cc_report 23:25:29 INFO - PROCESS | 1684 | __startTimestamp1467527129424__endTimestamp 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | ------- Summary: start ------- 23:25:29 INFO - PROCESS | 1684 | Number of tests: 6 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5975.89 Median:6204.04 stddev:659.93 (10.6%) stddev-sans-first:636.36 23:25:29 INFO - PROCESS | 1684 | Values: 3655.9 3663.1 3703.8 3724.6 3736.3 6023.1 6034.5 6048.6 6062.0 6100.4 5919.3 6026.8 6042.8 6079.3 6124.2 5350.2 5363.3 5401.2 5463.2 5472.0 5407.1 5476.2 5506.7 5524.4 5525.6 5448.8 5465.5 5465.6 5469.1 5478.1 5405.1 5461.5 5463.0 5465.8 5566.7 4538.3 5348.7 5439.0 5468.6 5490.4 6063.0 6106.3 6117.7 6121.6 6134.9 6205.7 6335.5 6372.5 6399.9 6470.5 6475.4 6492.4 6497.0 6502.8 6504.9 5202.8 5240.8 6197.6 6217.6 6225.9 6444.3 6545.9 6603.7 6692.3 6707.3 6333.5 6353.9 6360.3 6366.3 6372.8 6353.5 6486.4 6495.9 6504.7 6522.3 6273.8 6334.6 6336.0 6388.2 6394.4 4758.6 5536.6 6146.7 6354.0 6406.3 5061.6 5075.5 5080.4 5121.3 5164.2 4610.9 4615.3 4634.3 4644.2 4693.1 6128.6 6153.7 6170.7 6183.3 6187.5 6289.2 6384.9 6430.4 6543.1 6551.1 6078.0 6134.2 6167.9 6196.5 6204.9 5584.4 5606.1 5697.0 5715.3 5746.9 6590.3 6653.4 6756.4 6809.9 6811.3 6506.3 6540.9 6542.8 6546.3 6582.0 6781.0 6781.7 6796.8 6815.2 6816.5 5438.8 6286.7 6301.5 6339.3 6441.4 6451.0 6451.5 6463.8 6479.2 6491.5 6137.5 6263.6 6296.6 6299.8 6302.7 5633.7 5956.0 6206.8 6217.5 6299.7 6138.1 6204.0 6241.8 6253.5 6266.6 6173.4 6255.9 6307.5 6313.5 6319.9 6172.1 6237.5 6253.6 6282.9 6291.4 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:64041.19 Median:38840.20 stddev:137739.08 (354.6%) stddev-sans-first:138042.90 23:25:29 INFO - PROCESS | 1684 | Values: 519.4 526.3 564.0 598.1 617.2 38642.8 39662.2 39676.8 39737.0 39916.0 41238.4 41322.4 41929.6 42065.8 42096.4 9600.2 9688.4 9734.3 9744.3 9811.3 9689.4 9831.3 9877.8 9920.0 9935.0 8495.7 9731.2 9880.3 9918.0 9923.6 7723.5 9534.0 9720.7 9879.6 9926.5 9766.8 9782.8 9787.8 9827.3 9881.2 40062.0 40270.4 40560.8 40743.6 40808.0 3240.5 3351.6 3380.7 3380.9 3427.6 24404.1 26887.5 27691.6 28479.0 28644.4 2748.9 2767.0 2833.4 2839.3 2895.6 411419.0 415218.0 416109.0 421168.0 422186.0 36749.8 37715.8 49545.8 65261.0 65986.7 35941.6 36665.1 36682.8 36836.8 36921.4 15994.0 16295.3 16480.0 16503.6 16528.0 13896.1 13908.0 13957.9 13965.9 13972.7 8285.1 8348.8 8350.1 8485.5 8580.7 3565.9 3589.6 3598.7 3602.8 3614.0 1024.6 1052.9 1097.2 1184.7 1228.1 30785.2 30803.5 30976.0 31310.7 31501.0 1144.6 1166.7 1180.9 1193.5 1266.5 15811.8 15963.4 15985.3 16231.9 16297.5 502021.0 588175.0 588331.0 599542.0 608120.0 56878.4 62164.7 62297.1 62316.4 62353.0 1570.3 1582.8 1595.5 1602.9 1664.0 25681.9 29821.6 29952.4 30390.5 30755.0 52154.7 52234.7 52279.0 52633.0 52646.0 527432.0 536666.0 539072.0 544098.0 544197.0 26136.2 26754.3 26877.9 27586.3 27956.3 36543.5 38356.8 48396.5 48636.0 48829.3 38149.4 38818.2 39086.0 39201.0 39749.4 32252.0 38862.2 39026.4 39103.6 39279.6 33174.3 38070.2 38644.4 39019.8 39200.0 31838.5 33825.3 33976.7 34055.8 34103.0 25483.4 25500.7 25585.7 25730.0 26101.9 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:33387.87 Median:12255.23 stddev:99734.78 (813.8%) stddev-sans-first:99983.83 23:25:29 INFO - PROCESS | 1684 | Values: 413.5 415.8 417.5 423.6 424.8 20504.9 21184.7 21245.6 21347.3 22280.6 21561.7 21574.0 21802.2 21849.0 22139.0 5475.9 6147.3 6153.0 6265.8 6272.7 6118.4 6177.9 6187.1 6287.4 6353.8 5302.5 6002.7 6162.5 6253.7 6302.7 5736.2 6133.8 6236.6 6269.6 6363.0 4880.5 5776.4 5881.7 5884.1 5896.4 12794.4 13245.6 13375.8 13394.9 13529.9 2035.3 2073.8 2229.9 2347.2 2855.7 9690.8 10117.7 10156.8 10161.4 10279.2 1748.3 1766.7 1833.6 1864.3 1867.8 72547.5 75174.1 75409.1 112280.3 118873.8 11655.7 11936.7 12027.8 12194.0 12226.8 15558.6 15736.7 15824.5 15879.0 15910.0 9144.1 9233.5 9243.6 9307.7 9495.7 9162.2 9179.1 9326.6 9349.5 9476.8 4109.0 4803.3 4839.4 4946.8 4968.2 1616.7 1929.1 2104.2 2113.9 2144.3 875.6 944.0 1000.4 1055.8 1059.1 16137.9 17386.2 17633.7 21913.7 22092.6 948.9 953.9 1001.2 1043.3 1044.2 10641.6 11026.6 11452.6 11593.4 11812.4 273671.0 629983.0 651550.0 667628.7 679691.0 75589.9 105023.0 121294.8 129220.0 133394.0 964.6 1046.0 1061.0 1137.3 1138.3 16185.7 18657.0 19513.0 19529.9 20418.8 54535.7 54734.7 55483.6 56598.3 58152.7 81381.6 82391.6 82524.2 82838.2 83985.0 8459.8 8481.7 8510.9 8623.2 8806.6 10803.4 12473.8 13060.8 13511.5 13554.4 8319.6 9263.4 10872.7 10942.6 11450.3 8681.5 9252.8 9494.6 10626.6 10840.9 11674.9 11734.4 11779.3 11838.3 11972.0 8378.7 8473.5 8584.4 8627.6 8650.7 8584.8 11726.8 11786.7 11880.2 11950.9 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:5935.41 Median:5091.33 stddev:3303.20 (64.9%) stddev-sans-first:3295.39 23:25:29 INFO - PROCESS | 1684 | Values: 1466.3 1658.1 1913.3 2030.8 2097.7 7028.4 9046.3 9210.6 9426.2 9460.8 9039.1 9109.0 9189.7 9197.0 9198.6 2497.5 2507.1 2516.9 2535.7 2551.2 2515.7 2571.4 2584.8 2586.7 2589.5 2534.7 2567.4 2597.4 2599.4 2608.9 2525.8 2550.8 2571.6 2572.2 2588.1 2161.4 2499.9 2548.2 2570.6 2612.5 8007.1 9313.2 9345.4 9379.3 9393.0 5703.9 5710.2 5750.9 5859.9 5908.9 3240.0 3672.8 3815.3 3821.9 3878.8 980.6 1071.4 1095.3 1096.3 1097.2 12604.6 12704.0 12730.3 12741.5 12756.6 5082.0 5085.2 5097.5 5179.6 5238.3 9135.8 10801.9 10806.2 10808.3 10827.5 5705.0 5828.9 5860.1 5909.5 5910.2 4796.0 5157.4 5199.8 5251.9 5344.5 4247.8 4305.8 4340.3 4386.0 4414.2 1422.5 1463.1 1466.7 1479.1 1485.0 883.5 889.9 970.1 983.7 1012.7 4910.5 6061.2 6095.9 6169.5 6213.7 473.6 483.7 484.5 485.9 486.4 3992.5 4089.6 4111.9 4183.4 4199.7 10870.4 11058.9 11136.0 11164.1 11185.6 9682.3 10671.1 10834.0 10842.2 10996.6 8515.1 8587.0 8649.8 8660.5 8676.2 5968.6 5990.9 5992.8 6043.8 6058.8 9785.5 9846.9 9986.8 10007.5 10089.7 9852.2 10155.1 10163.6 10257.6 10269.9 5999.3 7680.8 7692.2 7855.3 7950.8 8636.4 8673.9 8714.0 8725.3 8744.5 6391.7 6648.6 7597.7 7715.7 7760.5 7542.2 7645.5 7650.9 7717.6 7758.7 7308.4 7358.7 7387.8 7388.0 7425.2 4382.6 5051.3 5053.8 5160.4 5194.2 5116.6 5117.5 5167.4 5233.2 5393.7 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:6017.73 Median:7000.27 stddev:1959.57 (28.0%) stddev-sans-first:1917.90 23:25:29 INFO - PROCESS | 1684 | Values: 323.8 333.6 342.9 344.3 346.3 6301.9 6818.7 7003.5 7063.7 7101.3 6503.2 6997.1 7019.3 7064.5 7079.2 5083.1 5100.9 5105.2 5106.5 5110.4 5118.7 5121.3 5126.3 5128.8 5143.4 5057.4 5060.4 5064.9 5076.2 5077.7 4043.4 4954.9 4982.6 5049.4 5083.7 4170.0 4211.1 4222.3 4223.4 4224.2 5590.3 6376.9 6599.6 6607.7 6657.6 5848.4 5932.1 5938.5 5940.0 5972.9 6082.9 7306.4 7316.5 7327.1 7337.5 4559.1 4637.8 4736.4 4736.6 4744.6 6990.8 7855.2 7889.9 7935.4 7952.1 4784.9 4815.3 4818.1 4819.8 4839.8 4907.1 4931.2 4934.7 4936.3 4937.4 4768.8 5935.0 5935.8 5951.4 5962.8 7208.4 7430.2 7465.6 7472.1 7522.1 1676.9 1687.7 1703.1 1704.4 1712.6 890.3 1012.5 1054.5 1065.9 1081.3 7021.5 7022.9 7030.5 7076.1 7087.5 6558.3 7634.7 7720.0 7736.0 7749.1 7021.6 7057.4 7075.0 7083.0 7094.8 3250.6 3952.1 4065.8 4090.8 4099.7 6470.0 8103.4 8125.6 8140.9 8169.8 7854.3 7981.7 7989.9 7990.7 8024.7 6487.9 8078.3 8087.0 8141.5 8184.3 6461.7 7449.3 7693.8 7721.6 7753.3 7564.2 7585.8 7589.4 7590.2 7600.4 7627.4 8105.9 8107.0 8120.6 8123.5 4656.0 4849.0 4851.6 4857.3 4860.2 7382.8 7627.4 7647.1 7664.8 7670.2 7306.3 7345.3 7372.2 7385.3 7410.9 7399.0 7402.3 7405.4 7415.9 7423.2 5844.7 6932.9 7222.1 7234.2 7240.6 7300.9 7380.6 7381.2 7392.7 7395.5 7050.8 7251.3 7350.4 7401.1 7401.6 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:18902.14 Median:26193.97 stddev:27001.19 (103.1%) stddev-sans-first:27042.36 23:25:29 INFO - PROCESS | 1684 | Values: 703.9 770.6 773.5 779.5 785.3 15309.8 15396.0 15730.1 15748.5 15769.1 14146.8 14282.4 14449.1 14476.6 14489.0 782.6 956.7 962.1 969.1 975.1 918.6 955.2 958.3 963.4 984.3 1005.4 1017.3 1021.9 1029.6 1038.0 960.8 1008.7 1010.8 1017.5 1029.8 742.7 743.7 749.7 774.5 778.2 14905.9 14922.6 14968.9 14969.5 15293.9 13520.1 13544.3 13595.0 13704.9 13754.7 10374.6 10389.6 10419.7 10461.2 10560.0 3653.6 3656.7 3660.4 3692.9 3728.6 62755.0 76949.6 77204.8 78873.8 78960.0 9708.2 9911.3 10112.3 10165.7 10320.5 22688.3 22752.4 23009.9 23495.5 23624.9 7650.6 7740.5 7813.3 7873.4 7940.0 4169.9 4199.5 4209.1 4220.5 4233.5 3692.2 3709.7 3766.7 3772.3 3773.4 700.1 702.8 706.7 716.6 737.0 525.7 547.8 609.2 624.9 635.5 8431.1 8636.1 8667.9 8770.8 8888.3 575.1 578.4 601.5 617.5 619.5 3902.9 3924.1 4029.9 4054.8 4180.7 99597.0 99686.0 100382.5 101374.5 101494.5 84118.0 85134.0 85407.0 85662.7 87554.0 68143.3 71974.6 72223.0 72633.0 72768.3 7889.2 7989.6 8066.9 8136.5 8176.4 51862.2 52948.0 53173.5 53470.0 54406.5 71016.0 72968.2 73000.5 73143.0 74164.0 10248.3 10358.8 10376.6 10549.9 10592.2 10895.8 10948.2 11100.7 11437.9 11441.7 10428.0 10518.4 10614.7 10851.9 11383.3 10608.0 10616.9 10724.6 10748.3 10944.2 10323.7 10429.5 10706.0 10978.3 10984.8 8396.9 9134.4 9170.9 9416.4 9605.7 9113.5 9242.0 9259.7 9315.5 9332.8 23:25:29 INFO - PROCESS | 1684 | -------- Summary: end -------- 23:25:29 INFO - PROCESS | 1684 | 23:25:29 INFO - TEST-INFO | 1684: exit 0 23:25:29 INFO - TEST-OK | dromaeo_css | took 1110409ms 23:25:29 INFO - TEST-START | kraken 23:25:29 INFO - operating with platform_type : mac_ 23:25:29 INFO - Initialising browser for kraken test... 23:25:29 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpNhlX6z/profile http://localhost:49271/getInfo.html) 23:25:32 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 23:25:32 INFO - PROCESS | 1691 | colorDepth:24 23:25:32 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 23:25:32 INFO - PROCESS | 1691 | __metrics 23:25:32 ERROR - PROCESS | 1691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:25:33 INFO - TEST-INFO | 1691: exit 0 23:25:33 INFO - Browser initialized. 23:25:33 INFO - Running cycle 1/1 for kraken test... 23:25:33 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/tmpNhlX6z/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 | 1695 | RSS: Main: 171208704 23:25:45 INFO - PROCESS | 1695 | 23:25:48 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:48 INFO - PROCESS | 1695 | RSS: Main: 183824384 23:25:48 INFO - PROCESS | 1695 | 23:25:51 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 23:25:52 INFO - PROCESS | 1695 | RSS: Main: 193040384 23:25:52 INFO - PROCESS | 1695 | 23:25:55 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 23:25:55 INFO - PROCESS | 1695 | RSS: Main: 196046848 23:25:55 INFO - PROCESS | 1695 | 23:25:57 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 23:25:58 INFO - PROCESS | 1695 | RSS: Main: 197808128 23:25:58 INFO - PROCESS | 1695 | 23:26:00 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:01 INFO - PROCESS | 1695 | RSS: Main: 198418432 23:26:01 INFO - PROCESS | 1695 | 23:26:04 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:04 INFO - PROCESS | 1695 | RSS: Main: 198692864 23:26:04 INFO - PROCESS | 1695 | 23:26:07 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:08 INFO - PROCESS | 1695 | RSS: Main: 198402048 23:26:08 INFO - PROCESS | 1695 | 23:26:11 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 23:26:11 INFO - PROCESS | 1695 | RSS: Main: 198586368 23:26:11 INFO - PROCESS | 1695 | 23:26:13 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:14 INFO - PROCESS | 1695 | RSS: Main: 197955584 23:26:14 INFO - PROCESS | 1695 | 23:26:15 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:16 INFO - PROCESS | 1695 | RSS: Main: 197984256 23:26:16 INFO - PROCESS | 1695 | 23:26:18 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:19 INFO - PROCESS | 1695 | RSS: Main: 197943296 23:26:19 INFO - PROCESS | 1695 | 23:26:21 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:22 INFO - PROCESS | 1695 | RSS: Main: 198115328 23:26:22 INFO - PROCESS | 1695 | 23:26:25 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:25 INFO - PROCESS | 1695 | RSS: Main: 198074368 23:26:25 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 23:26:27 INFO - PROCESS | 1695 | RSS: Main: 199847936 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | __start_tp_report 23:26:27 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 23:26:27 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 23:26:27 INFO - PROCESS | 1695 | |i|pagename|runs| 23:26:27 INFO - PROCESS | 1695 | |0;ai-astar;116;112;117;117;115;131;142;167;162;115 23:26:27 INFO - PROCESS | 1695 | |1;audio-beat-detection;156;119;148;182;119;136;121;158;137;132 23:26:27 INFO - PROCESS | 1695 | |2;audio-dft;195;197;191;196;194;196;199;194;198;193 23:26:27 INFO - PROCESS | 1695 | |3;audio-fft;68;83;70;165;84;84;81;58;123;57 23:26:27 INFO - PROCESS | 1695 | |4;audio-oscillator;76;80;120;76;74;94;118;78;106;104 23:26:27 INFO - PROCESS | 1695 | |5;imaging-gaussian-blur;90;87;124;81;135;129;95;88;90;89 23:26:27 INFO - PROCESS | 1695 | |6;imaging-darkroom;95;96;96;98;97;95;96;95;95;96 23:26:27 INFO - PROCESS | 1695 | |7;imaging-desaturate;143;145;98;93;90;77;115;132;81;144 23:26:27 INFO - PROCESS | 1695 | |8;json-parse-financial;60;64;65;65;64;84;98;112;78;59 23:26:27 INFO - PROCESS | 1695 | |9;json-stringify-tinderbox;64;65;72;69;69;70;72;66;65;66 23:26:27 INFO - PROCESS | 1695 | |10;stanford-crypto-aes;81;81;82;80;80;81;76;79;82;84 23:26:27 INFO - PROCESS | 1695 | |11;stanford-crypto-ccm;124;125;132;141;146;131;131;142;152;140 23:26:27 INFO - PROCESS | 1695 | |12;stanford-crypto-pbkdf2;167;173;172;170;217;170;164;164;162;170 23:26:27 INFO - PROCESS | 1695 | |13;stanford-crypto-sha256-iterative;68;67;69;66;69;68;67;70;83;80 23:26:27 INFO - PROCESS | 1695 | __end_tp_report 23:26:27 INFO - PROCESS | 1695 | __start_cc_report 23:26:27 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,1030 23:26:27 INFO - PROCESS | 1695 | __end_cc_report 23:26:27 INFO - PROCESS | 1695 | __startTimestamp1467527187934__endTimestamp 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | ------- Summary: start ------- 23:26:27 INFO - PROCESS | 1695 | Number of tests: 14 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#0] ai-astar Cycles:10 Average:129.40 Median:124.00 stddev:20.66 (16.7%) stddev-sans-first:21.34 23:26:27 INFO - PROCESS | 1695 | Values: 116.0 112.0 117.0 117.0 115.0 131.0 142.0 167.0 162.0 115.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:142.50 stddev:20.37 (14.3%) stddev-sans-first:20.85 23:26:27 INFO - PROCESS | 1695 | Values: 156.0 119.0 148.0 182.0 119.0 136.0 121.0 158.0 137.0 132.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#2] audio-dft Cycles:10 Average:195.30 Median:196.00 stddev:2.41 (1.2%) stddev-sans-first:2.55 23:26:27 INFO - PROCESS | 1695 | Values: 195.0 197.0 191.0 196.0 194.0 196.0 199.0 194.0 198.0 193.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.50 stddev:33.07 (43.8%) stddev-sans-first:34.33 23:26:27 INFO - PROCESS | 1695 | Values: 68.0 83.0 70.0 165.0 84.0 84.0 81.0 58.0 123.0 57.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:76.00 stddev:18.19 (23.9%) stddev-sans-first:18.27 23:26:27 INFO - PROCESS | 1695 | Values: 76.0 80.0 120.0 76.0 74.0 94.0 118.0 78.0 106.0 104.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#5] imaging-gaussian-blur Cycles:10 Average:100.80 Median:88.50 stddev:20.15 (22.8%) stddev-sans-first:20.99 23:26:27 INFO - PROCESS | 1695 | Values: 90.0 87.0 124.0 81.0 135.0 129.0 95.0 88.0 90.0 89.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 23:26:27 INFO - PROCESS | 1695 | Values: 95.0 96.0 96.0 98.0 97.0 95.0 96.0 95.0 95.0 96.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#7] imaging-desaturate Cycles:10 Average:111.80 Median:79.00 stddev:27.30 (34.6%) stddev-sans-first:26.52 23:26:27 INFO - PROCESS | 1695 | Values: 143.0 145.0 98.0 93.0 90.0 77.0 115.0 132.0 81.0 144.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#8] json-parse-financial Cycles:10 Average:74.90 Median:65.00 stddev:17.98 (27.7%) stddev-sans-first:18.25 23:26:27 INFO - PROCESS | 1695 | Values: 60.0 64.0 65.0 65.0 64.0 84.0 98.0 112.0 78.0 59.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:69.00 stddev:2.97 (4.3%) stddev-sans-first:2.82 23:26:27 INFO - PROCESS | 1695 | Values: 64.0 65.0 72.0 69.0 69.0 70.0 72.0 66.0 65.0 66.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:2.12 (2.6%) stddev-sans-first:2.24 23:26:27 INFO - PROCESS | 1695 | Values: 81.0 81.0 82.0 80.0 80.0 81.0 76.0 79.0 82.0 84.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:140.50 stddev:9.20 (6.6%) stddev-sans-first:8.60 23:26:27 INFO - PROCESS | 1695 | Values: 124.0 125.0 132.0 141.0 146.0 131.0 131.0 142.0 152.0 140.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:170.00 stddev:15.93 (9.4%) stddev-sans-first:16.75 23:26:27 INFO - PROCESS | 1695 | Values: 167.0 173.0 172.0 170.0 217.0 170.0 164.0 164.0 162.0 170.0 23:26:27 INFO - PROCESS | 1695 | 23:26:27 INFO - PROCESS | 1695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:69.00 stddev:5.85 (8.5%) stddev-sans-first:6.12 23:26:27 INFO - PROCESS | 1695 | Values: 68.0 67.0 69.0 66.0 69.0 68.0 67.0 70.0 83.0 80.0 23:26:27 INFO - PROCESS | 1695 | -------- Summary: end -------- 23:26:27 INFO - PROCESS | 1695 | 23:26:28 INFO - TEST-INFO | 1695: exit 0 23:26:28 INFO - TEST-OK | kraken | took 58771ms 23:26:28 INFO - SUITE-END | took 1169s 23:26:29 INFO - Completed test suite (00:19:29) 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": [3655.8903232903012, 3663.13916229686, 3703.796291203986, 3724.646158614932, 3736.290104880074, 6023.096535519663, 6034.456898879105, 6048.637081775097, 6061.969465190917, 6100.359462256466, 5919.260092488439, 6026.758929642809, 6042.758289668408, 6079.300880398756, 6124.173236613055, 5350.224217488462, 5363.326979311181, 5401.189821526763, 5463.235147079412, 5472.042392581302, 5407.080796264644, 5476.2333273341765, 5506.669599824003, 5524.392316845144, 5525.640833345839, 5448.782048718046, 5465.453454654543, 5465.59008074396, 5469.07025805614, 5478.068728316176, 5405.135178371462, 5461.5357694596005, 5462.972685136589, 5465.781368745245, 5566.693831839248, 4538.319252112209, 5348.732563371855, 5438.972805135989, 5468.644538105011, 5490.368607610136, 6062.969685151546, 6106.297775755756, 6117.66352850593, 6121.602095863799, 6134.8773024539705, 6205.658688772116, 6335.493160547145, 6372.522060845455, 6399.93600063998, 6470.547061705683, 6475.417212450902, 6492.350764923517, 6497.0, 6502.837429064264, 6504.902426463606, 5202.843914682566, 5240.842774716764, 6197.597156184834, 6217.595856269328, 6225.875482490324, 6444.258910225384, 6545.934540654533, 6603.669816509156, 6692.297308782508, 6707.3292670732535, 6333.524985626096, 6353.904691429632, 6360.268569114611, 6366.299707032223, 6372.776952806629, 6353.491720662336, 6486.383793539606, 6495.8700825983215, 6504.739810407626, 6522.315156908551, 6273.780417685359, 6334.588251763621, 6336.049592561153, 6388.201474815648, 6394.360563943662, 4758.571728544448, 5536.557075433956, 6146.661933593696, 6354.0, 6406.2953075161695, 5061.569766569883, 5075.492450754969, 5080.364954380702, 5121.334226550599, 5164.1995490699, 4610.907781844345, 4615.30770384445, 4634.328022436795, 4644.187267228289, 4693.131770622445, 6128.601640893327, 6153.692315384303, 6170.7223174957235, 6183.319834818167, 6187.535934804908, 6289.182406287245, 6384.872302553923, 6430.356964303533, 6543.149390579194, 6551.082848401227, 6077.969610152009, 6134.202553667995, 6167.907481387782, 6196.504279657616, 6204.875902482016, 5584.413636568183, 5606.131049687224, 5697.0, 5715.314162300468, 5746.88506229873, 6590.3080176581725, 6653.401193892573, 6756.391924726799, 6809.93190068093, 6811.284815094443, 6506.284308726131, 6540.869182616416, 6542.771003015062, 6546.279909210079, 6581.967090164519, 6780.96609516969, 6781.6948237330425, 6796.796096117125, 6815.216250131299, 6816.522843400914, 5438.809641662523, 6286.654234017173, 6301.464375528131, 6339.3343698912795, 6441.3880681335195, 6450.967745161244, 6451.48388128958, 6463.838404039937, 6479.1901012373455, 6491.545591808528, 6137.508999280136, 6263.561550691408, 6296.5592408530965, 6299.842503937438, 6302.716377763103, 5633.6619802811965, 5956.017257152521, 6206.751729930752, 6217.502599792097, 6299.685015749286, 6138.109974053648, 6204.038374052029, 6241.843953901007, 6253.499720022296, 6266.624002559861, 6173.382661733791, 6255.9374406257175, 6307.526935479766, 6313.494920406265, 6319.905201422074, 6172.074188871705, 6237.5321850860455, 6253.593516421418, 6282.937170628235, 6291.433770960635], "value": 5936.907197779019, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.3637793702712, 526.2632314759337, 563.9718014099294, 598.0938877600436, 617.1822335405586, 38642.806785966066, 39662.20675586486, 39676.80161599191, 39737.0, 39916.0, 41238.350465981326, 41322.38016429756, 41929.58070419295, 42065.78967105168, 42096.36855447171, 9600.18398436132, 9688.370255933378, 9734.26992975526, 9744.269179811507, 9811.313208075437, 9689.418634881895, 9831.31180817343, 9877.802443951117, 9919.950400247988, 9934.9503252484, 8495.74512764618, 9731.172850307732, 9880.308378413514, 9918.008199180096, 9923.603055877757, 7723.459357844981, 9534.0, 9720.659776907845, 9879.555420006118, 9926.45404502752, 9766.755831104208, 9782.755431114208, 9787.755306117333, 9827.262955278382, 9881.209503239723, 40062.0, 40270.39594406086, 40560.79719601413, 40743.59256407428, 40807.97980050493, 3240.4653232216892, 3351.6480769519335, 3380.678835510623, 3380.881669141568, 3427.5886893572683, 24404.145854894992, 26887.46225075507, 27691.584626230622, 28479.003234886888, 28644.427111457655, 2748.945021099587, 2766.986165069162, 2833.4474777418413, 2839.304370429237, 2895.6380452443445, 411419.0, 415218.0, 416109.0, 421167.9999999969, 422186.0, 36749.81625091857, 37715.81142094272, 49545.75227123914, 65261.0, 65986.67006664936, 35941.64058359383, 36665.08337291589, 36682.8165859169, 36836.81581592128, 36921.44617830735, 15994.0, 16295.348186072424, 16480.011199328077, 16503.587410314838, 16528.0, 13896.096753710977, 13908.0, 13957.860421395657, 13965.930170349084, 13972.650683732989, 8285.088640249567, 8348.831163637096, 8350.123237060021, 8485.533295668798, 8580.742577722678, 3565.8573657053425, 3589.587197472272, 3598.712103031751, 3602.819859007039, 3613.9638603613625, 1024.636254129788, 1052.8894466081103, 1097.1958340379304, 1184.7334349771404, 1228.0973484488893, 30785.230369240948, 30803.537946930814, 30976.0, 31310.68689313123, 31501.0, 1144.6222746493804, 1166.6791632301185, 1180.9291442513477, 1193.4927655746274, 1266.4870727355435, 15811.841881581267, 15963.44127955516, 15985.280662369989, 16231.918840405722, 16297.511074667778, 502021.0, 588175.0, 588331.0, 599542.0, 608120.0, 56878.43121568731, 62164.68917655473, 62297.06554401688, 62316.37683623106, 62353.0, 1570.2541292886017, 1582.786323846289, 1595.5213435969163, 1602.8637565807037, 1664.0015990405902, 25681.871590641927, 29821.552676709434, 29952.405711314783, 30390.544141837447, 30755.0, 52154.73922630362, 52234.73882630715, 52279.0, 52633.0, 52646.0, 527432.0, 536666.0, 539072.0, 544098.0, 544197.0, 26136.215913522625, 26754.331141720835, 26877.92488300446, 27586.310342240802, 27956.301092472037, 36543.45184822283, 38356.80821595874, 48396.516034840606, 48636.027279453505, 48829.2675609859, 38149.427758583086, 38818.18272421956, 39086.0, 39201.0, 39749.403758944216, 32252.0, 38862.222755544164, 39026.41460378154, 39103.608963909996, 39279.6072039276, 33174.336513270086, 38070.2385952285, 38644.420333694456, 39019.80490097645, 39200.0, 31838.522422163223, 33825.3234935295, 33976.66023339735, 34055.82972085124, 34102.97691069272, 25483.36291592725, 25500.74499255058, 25585.744142558335, 25730.0, 26101.869490653185], "value": 18828.45598137804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.53477337994747, 415.8295099009409, 417.5177669791388, 423.6060463768694, 424.7897290841033, 20504.897475512622, 21184.682229766568, 21245.57508849822, 21347.252846150386, 22280.554388912253, 21561.67657485139, 21574.0, 21802.236921707743, 21849.0, 22139.00374483148, 5475.917861232075, 6147.262328520584, 6153.0, 6265.843353916143, 6272.68636568172, 6118.430259291108, 6177.938220617803, 6187.133801267826, 6287.402696743825, 6353.809385718436, 5302.496262855023, 6002.679410529677, 6162.4761895238735, 6253.7185826637915, 6302.653354065525, 5736.168255602956, 6133.754649814002, 6236.594621349621, 6269.59247648906, 6363.013732871413, 4880.487548807395, 5776.422357764232, 5881.67650779207, 5884.117382392633, 5896.38088000758, 12794.42425090873, 13245.602631921058, 13375.799363009563, 13394.866051339557, 13529.932350338284, 2035.3181684135832, 2073.8237249833783, 2229.9108035678555, 2347.2254156128606, 2855.657840814814, 9690.75773105671, 10117.696469105938, 10156.796864062751, 10161.441120738356, 10279.229057820694, 1748.2657283940775, 1766.6643337765784, 1833.62410705805, 1864.3102052240758, 1867.8318951294314, 72547.54904901872, 75174.12064698426, 75409.11477213059, 112280.31579526313, 118873.81126188714, 11655.708607284716, 11936.701582460508, 12027.759444811054, 12194.0, 12226.75546489083, 15558.611034724223, 15736.685266294839, 15824.525264242091, 15879.0, 15910.0453972762, 9144.085591440802, 9233.53832308382, 9243.584038718274, 9307.72076837696, 9495.715128546155, 9162.175404213653, 9179.0820917909, 9326.580303886205, 9349.532523373804, 9476.810463790685, 4109.0, 4803.279508073817, 4839.370881785346, 4946.802127914915, 4968.180250258739, 1616.7494038424063, 1929.1126082002436, 2104.168853302937, 2113.9218998310666, 2144.292383513437, 875.605977310213, 943.9952800235955, 1000.3847633705365, 1055.8416237564272, 1059.1156384419096, 16137.919310403373, 17386.21762020712, 17633.7354939676, 21913.671294930587, 22092.55814883693, 948.8671585977969, 953.9046095390405, 1001.1940387987594, 1043.2592859070146, 1044.2324891204958, 10641.627543036111, 11026.558937642565, 11452.59915902956, 11593.365830341636, 11812.40937953099, 273671.0, 629983.0, 651550.0, 667628.6618566876, 679691.0, 75589.86615200776, 105023.0, 121294.78705213011, 129220.0, 133394.0, 964.647903515226, 1045.9790804183874, 1060.9575616975235, 1137.2721458266717, 1138.3283862521153, 16185.67628647444, 18656.973866437474, 19513.0, 19529.902350488155, 20418.795812042285, 54535.72732136314, 54734.726326368116, 55483.612909677584, 56598.30205093854, 58152.70923645355, 81381.59309203416, 82391.5880420594, 82524.17475825406, 82838.17161828304, 83985.0, 8459.788505287417, 8481.660733570588, 8510.914890851012, 8623.223909848144, 8806.559672016501, 10803.351798892092, 12473.750524989631, 13060.804087938499, 13511.527096551574, 13554.390052447467, 8319.584020799057, 9263.425217712871, 10872.726727537296, 10942.617008404668, 11450.255733377304, 8681.479111253346, 9252.814943700954, 9494.620215191315, 10626.628068017582, 10840.945795270973, 11674.883251167379, 11734.354610496504, 11779.293242405483, 11838.28970261787, 11972.042236620875, 8378.748637540884, 8473.491590504344, 8584.442011269248, 8627.611757471055, 8650.697225597074, 8584.828303434022, 11726.824097638713, 11786.705332366759, 11880.227785193934, 11950.880491194977], "value": 9550.037393984634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.3474753734588, 1658.0880515716358, 1913.2538310059078, 2030.7766145723967, 2097.6538871086273, 7028.367446929776, 9046.27629789617, 9210.585523651434, 9426.151646351827, 9460.763480912981, 9039.096090390958, 9108.998010218887, 9189.724308270746, 9197.034311397307, 9198.63205471782, 2497.463045445229, 2507.122507122511, 2516.8615726135054, 2535.695716514021, 2551.2473820223076, 2515.6603858479148, 2571.4471388651436, 2584.8319859209187, 2586.7154612992554, 2589.4950484655405, 2534.6958364996135, 2567.4094958159635, 2597.3506623344165, 2599.350162459385, 2608.9086881959133, 2525.8231923765343, 2550.8341957772777, 2571.639970404145, 2572.176903390916, 2588.0682954136496, 2161.4056134562966, 2499.87500624968, 2548.2482667612912, 2570.6144078388206, 2612.477504499108, 8007.119216886138, 9313.161815436575, 9345.392549484262, 9379.296552758571, 9393.0, 5703.857403564903, 5710.229119068914, 5750.913736293959, 5859.912101318484, 5908.852278693024, 3239.967600324014, 3672.779633222015, 3815.313243616148, 3821.9044523887123, 3878.8448462061483, 980.5587485631495, 1071.3893080943865, 1095.2990086344746, 1096.3257596578126, 1097.226455348977, 12604.558840440632, 12704.0, 12730.299833509152, 12741.490340386374, 12756.617301481063, 5081.974590127025, 5085.160948443539, 5097.490250974873, 5179.637425380262, 5238.319018527567, 9135.771605709777, 10801.945990269998, 10806.243562950518, 10808.297460665031, 10827.512761925733, 5705.0, 5828.941710582924, 5860.120981852756, 5909.468147866713, 5910.172575839386, 4795.976020119947, 5157.406898206679, 5199.844004679866, 5251.894962100737, 5344.518993290622, 4247.787610619456, 4305.84929527465, 4340.283853164193, 4385.956140438555, 4414.249577571756, 1422.4807945100172, 1463.129437984419, 1466.6846627974824, 1479.1125324805246, 1485.042147814675, 883.4831623500196, 889.902110767815, 970.0583923468754, 983.6655537117415, 1012.6759436980243, 4910.533499317559, 6061.242344706911, 6095.878082438415, 6169.5064394848305, 6213.720382582795, 473.60690626780377, 483.7411984588299, 484.4719256010965, 485.8532425746309, 486.4381639206722, 3992.461017762565, 4089.5910408958866, 4111.8972025698995, 4183.435236243129, 4199.727017743837, 10870.402127882884, 11058.944705276423, 11136.0, 11164.05105566036, 11185.608503702331, 9682.273829462818, 10671.146308295318, 10834.0, 10842.241043127064, 10996.615118470816, 8515.063343032261, 8587.0, 8649.783755406164, 8660.48037117775, 8676.219140277279, 5968.552358573212, 5990.910136347871, 5992.820215393545, 6043.758249669964, 6058.848528786815, 9785.461799601091, 9846.901530984598, 9986.800263994533, 10007.549660265451, 10089.747756306151, 9852.162566181954, 10155.086042256233, 10163.644272450429, 10257.58969641206, 10269.870314265574, 5999.250093738283, 7680.807979800326, 7692.230776922263, 7855.293023627901, 7950.840983180188, 8636.352273579632, 8673.913260867563, 8714.0, 8725.301975842045, 8744.519051451976, 6391.712372943136, 6648.634325112165, 7597.696092156252, 7715.652795624323, 7760.495567788075, 7542.2224880860595, 7645.541267523967, 7650.885236721342, 7717.614119294125, 7758.68965241384, 7308.415326773739, 7358.705651773869, 7387.8153046174275, 7388.0, 7425.183229844821, 4382.561743825592, 5051.318072060225, 5053.797848086036, 5160.432352441304, 5194.246834209094, 5116.565091967075, 5117.5394214520875, 5167.431582525844, 5233.188855727369, 5393.730313484231], "value": 4730.874209758786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.75879969422783, 333.6246722437258, 342.8599905314828, 344.2890431259449, 346.321210427562, 6301.8656641804455, 6818.65906704664, 7003.474739394546, 7063.717451301948, 7101.254368291333, 6503.154589903318, 6997.055397521333, 7019.262977387378, 7064.540804847681, 7079.221285658574, 5083.059633967719, 5100.928804950946, 5105.18317069269, 5106.540411362977, 5110.437851836295, 5118.744062796864, 5121.308623335858, 5126.333576635051, 5128.794848206067, 5143.382794064699, 5057.443681195084, 5060.367454068241, 5064.949350506485, 5076.187809950408, 5077.695338279696, 4043.353063509824, 4954.925676114861, 4982.60139188864, 5049.444561098277, 5083.720395378253, 4169.97915010426, 4211.05251318454, 4222.3244280914905, 4223.408722778782, 4224.2185195738575, 5590.301212348457, 6376.872462550769, 6599.637019963948, 6607.669616519155, 6657.600543967377, 5848.385919478436, 5932.139839723259, 5938.465538101592, 5940.0, 5972.880542389172, 6082.905077086123, 7306.415486761046, 7316.524425912352, 7327.0841144856895, 7337.523061001018, 4559.133764584718, 4637.791299391535, 4736.360591320196, 4736.621070314367, 4744.572988431023, 6990.825229369256, 7855.214478552156, 7889.921100788976, 7935.444518883681, 7952.125266220711, 4784.880377990508, 4815.3258543803895, 4818.084563932842, 4819.831305904277, 4839.814245509872, 4907.067657145202, 4931.161702510582, 4934.679245849008, 4936.259561065869, 4937.35814344133, 4768.809247630125, 5935.0, 5935.821925342247, 5951.434613711691, 5962.821115366546, 7208.387287080552, 7430.219826918204, 7465.626718664045, 7472.103347598323, 7522.059742532184, 1676.8993860368416, 1687.738400547917, 1703.097358400025, 1704.3779020657619, 1712.5975395781982, 890.2610833008588, 1012.473513772834, 1054.4938429553856, 1065.9040686338112, 1081.2863510083307, 7021.508494405445, 7022.894656580155, 7030.543014704028, 7076.0801095857205, 7087.539309944837, 6558.311377305409, 7634.732784352521, 7719.961400193076, 7736.032995875516, 7749.108852481924, 7021.578705277598, 7057.435405167575, 7075.0, 7082.964585177041, 7094.751683691046, 3250.6424293327714, 3952.0910190655736, 4065.756054636672, 4090.775007374623, 4099.692523060782, 6469.967650161719, 8103.392245581487, 8125.553094579855, 8140.877886831702, 8169.754907352789, 7854.253845884632, 7981.72063977758, 7989.920100799034, 7990.720324788605, 8024.719134830253, 6487.870242595121, 8078.3133433658795, 8086.999999999883, 8141.470804397695, 8184.345252379795, 6461.709223085067, 7449.329560339595, 7693.807654808675, 7721.575313357819, 7753.302202801775, 7564.243575642392, 7585.848283034419, 7589.354904833151, 7590.203028681909, 7600.3539699126195, 7627.351675107678, 8105.8784118239455, 8107.0, 8120.553369564731, 8123.512589244664, 4656.0, 4849.0, 4851.56335929768, 4857.271409288635, 4860.173770459101, 7382.815429614303, 7627.351675107678, 7647.120581133241, 7664.846703065796, 7670.232976702285, 7306.269373062863, 7345.338919497271, 7372.225916278713, 7385.335319821242, 7410.888836667562, 7398.96300518494, 7402.33378995893, 7405.44459165554, 7415.924690919895, 7423.183449820407, 5844.707764611838, 6932.861342773217, 7222.0611320528, 7234.16807067194, 7240.565566066053, 7300.926990730025, 7380.594067326134, 7381.1511676157925, 7392.741254056083, 7395.482316237812, 7050.753223637148, 7251.274872512707, 7350.448716346403, 7401.111866576045, 7401.555906645618], "value": 5354.311639351828, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.8873780195169, 770.6493545436826, 773.4508498965735, 779.4894344204545, 785.3128512551517, 15309.77035344468, 15396.0, 15730.056196628211, 15748.527544173694, 15769.053856768602, 14146.78779818301, 14282.428702851874, 14449.133052016887, 14476.638084047903, 14489.0, 782.6282515805004, 956.741679746468, 962.0667952086483, 969.0793745941384, 975.068809287129, 918.6187732091174, 955.2405837359281, 958.314804914486, 963.3786207895903, 984.2716389871515, 1005.3967619428357, 1017.3488967061087, 1021.9284650074461, 1029.5727273181622, 1038.0035166240418, 960.8318544254728, 1008.742770593494, 1010.8483727440906, 1017.5065093429681, 1029.7785976015155, 742.6583771465132, 743.7248218159261, 749.6963729689485, 774.5236679442158, 778.1634742651672, 14905.925470372687, 14922.552323430315, 14968.850311496963, 14969.476068337664, 15293.923530382388, 13520.12119212248, 13544.255065971367, 13594.980376471804, 13704.931475342559, 13754.65613359664, 10374.585016599327, 10389.636362727344, 10419.687409377731, 10461.163106951426, 10560.0, 3653.5615726113037, 3656.725745569093, 3660.432632941898, 3692.8892133235777, 3728.6457786510236, 62755.0, 76949.61525192339, 77204.8419273717, 78873.81689274666, 78960.0, 9708.223342132613, 9911.306208565475, 10112.292139550307, 10165.745856353502, 10320.48397580118, 22688.319350419515, 22752.431189220402, 23009.884950575473, 23495.530089398115, 23624.881875590512, 7650.579218142944, 7740.496867703581, 7813.257740514642, 7873.37013038967, 7940.007499062617, 4169.854055108057, 4199.517055538591, 4209.074003719177, 4220.514640816284, 4233.5131459881895, 3692.2061756722433, 3709.666130048309, 3766.6798322142376, 3772.320982223171, 3773.4339849022867, 700.1423256510835, 702.8242939265184, 706.6961206681176, 716.6452605960083, 736.9594672292968, 525.7108590275333, 547.8219578636958, 609.2171559545963, 624.9406306400884, 635.462181520721, 8431.114732953074, 8636.136386361313, 8667.869981950276, 8770.824583508294, 8888.29242591439, 575.1459083261353, 578.3695771608966, 601.5368166511848, 617.4751461257895, 619.5167769140078, 3902.921941561153, 3924.117073658404, 4029.8589549365634, 4054.7567145971334, 4180.665546756252, 99597.0, 99686.006279874, 100382.49808751055, 101374.49312753389, 101494.49252753837, 84118.0, 85134.0, 85407.0, 85662.71505927417, 87554.0, 68143.3185668137, 71974.64012679903, 72223.0, 72633.0, 72768.27231727615, 7889.171636978264, 7989.600519974094, 8066.878996814935, 8136.511809291462, 8176.427650064438, 51862.22206666828, 52948.0, 53173.46826531685, 53470.0, 54406.45593544172, 71016.0, 72968.17579560554, 73000.53998920097, 73143.0, 74164.0, 10248.282620216512, 10358.792824143324, 10376.628785624906, 10549.947250264007, 10592.152627789605, 10895.782084358427, 10948.178886583697, 11100.666979990614, 11437.942810286228, 11441.713957150805, 10428.009339112772, 10518.421486818299, 10614.681559553226, 10851.914808519401, 11383.317000979967, 10608.0, 10616.89383106159, 10724.624638137628, 10748.301360411548, 10944.179186560881, 10323.741906452398, 10429.478526073817, 10706.036456718934, 10978.286411383235, 10984.780304394028, 8396.916030839613, 9134.406263592846, 9170.862437063315, 9416.435013899189, 9605.663801766905, 9113.453192808453, 9242.0, 9259.67591134307, 9315.534223288943, 9332.766680833034], "value": 7084.698022996529, "unit": "score"}], "name": "dromaeo_css", "value": 7592.704921657798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 117.0, 117.0, 115.0, 131.0, 142.0, 167.0, 162.0, 115.0], "value": 129.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 148.0, 182.0, 119.0, 136.0, 121.0, 158.0, 137.0, 132.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 197.0, 191.0, 196.0, 194.0, 196.0, 199.0, 194.0, 198.0, 193.0], "value": 195.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 83.0, 70.0, 165.0, 84.0, 84.0, 81.0, 58.0, 123.0, 57.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 120.0, 76.0, 74.0, 94.0, 118.0, 78.0, 106.0, 104.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 124.0, 81.0, 135.0, 129.0, 95.0, 88.0, 90.0, 89.0], "value": 100.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 98.0, 97.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 145.0, 98.0, 93.0, 90.0, 77.0, 115.0, 132.0, 81.0, 144.0], "value": 111.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 64.0, 65.0, 65.0, 64.0, 84.0, 98.0, 112.0, 78.0, 59.0], "value": 74.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 72.0, 69.0, 69.0, 70.0, 72.0, 66.0, 65.0, 66.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 80.0, 80.0, 81.0, 76.0, 79.0, 82.0, 84.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 132.0, 141.0, 146.0, 131.0, 131.0, 142.0, 152.0, 140.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 172.0, 170.0, 217.0, 170.0, 164.0, 164.0, 162.0, 170.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 69.0, 68.0, 67.0, 70.0, 83.0, 80.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1557.2, "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.233 screenresolution[1700:16579] starting screenresolution argv=screenresolution get 23:26:29 INFO - 2016-07-02 23:26:29.235 screenresolution[1700:16579] Display 0: 1600x1200x32@60 23:26:29 INFO - 2016-07-02 23:26:29.241 screenresolution[1701:16582] 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: 1193s; CPU: 53.0%; Read bytes: 31641088; Write bytes: 495099904; Read time: 198; Write time: 1553 23:26:30 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 237568; Write bytes: 194723840; Read time: 3; Write time: 436 23:26:30 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29859328; Write bytes: 299528192; Read time: 182; Write time: 1114 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:30 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:31 INFO - (blobuploader) - INFO - Done attempting. 23:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:32 INFO - (blobuploader) - INFO - Done attempting. 23:26:32 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:32 INFO - Return code: 0 23:26:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/614a66bcef686bed529eab208893c1a38ccc8860e99a6f6410ec89d54fde5aec2638469da4da8b57b74fa9d5defc150094049f9f6357beafe4748dc212dfe1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da3cda20babb05decb83a2c8e976a47c9329613b88eaa129db72572381c87f1ec62e230d7c199e50d580e1e340bdd7e764fb9cd592badccee64158633aae34bc"} 23:26:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:32 INFO - Contents: 23:26:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/614a66bcef686bed529eab208893c1a38ccc8860e99a6f6410ec89d54fde5aec2638469da4da8b57b74fa9d5defc150094049f9f6357beafe4748dc212dfe1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da3cda20babb05decb83a2c8e976a47c9329613b88eaa129db72572381c87f1ec62e230d7c199e50d580e1e340bdd7e764fb9cd592badccee64158633aae34bc"} 23:26:32 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:32 INFO - Copying logs to upload dir... 23:26:32 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.173929 ========= master_lag: 1.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-02 23:26:34.264666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:34.268651) ========= 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.wJpngvwwaB/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.9a2ne7MtEy/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/614a66bcef686bed529eab208893c1a38ccc8860e99a6f6410ec89d54fde5aec2638469da4da8b57b74fa9d5defc150094049f9f6357beafe4748dc212dfe1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da3cda20babb05decb83a2c8e976a47c9329613b88eaa129db72572381c87f1ec62e230d7c199e50d580e1e340bdd7e764fb9cd592badccee64158633aae34bc"} 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.011243 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467380997/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/614a66bcef686bed529eab208893c1a38ccc8860e99a6f6410ec89d54fde5aec2638469da4da8b57b74fa9d5defc150094049f9f6357beafe4748dc212dfe1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da3cda20babb05decb83a2c8e976a47c9329613b88eaa129db72572381c87f1ec62e230d7c199e50d580e1e340bdd7e764fb9cd592badccee64158633aae34bc"}' ========= master_lag: 0.81 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.089098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.089393) ========= 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.wJpngvwwaB/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.9a2ne7MtEy/Listeners TMPDIR=/var/folders/w5/_34gntw956zgpct1x2hz28jh00000w/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.005073 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:35.136892) ========= ========= Started reboot skipped (results: 3, elapsed: 9 secs) (at 2016-07-02 23:26:35.137154) ========= ========= Finished reboot skipped (results: 3, elapsed: 9 secs) (at 2016-07-02 23:26:44.390748) ========= ========= Total master_lag: 2.32 =========