builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0129 starttime: 1461032262.88 results: success (0) buildid: 20160418173320 builduid: ce0f15b7f13645da9aea21f46dbb0eb5 revision: 1287b9f362ee36de3898ffdc09767f8ea85b2494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:42.877268) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:42.877764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:42.878043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:42.905074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 19:17:42.905465) ========= 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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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-04-18 19:17:43-- 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% 154M=0s 2016-04-18 19:17:43 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.520162 ========= master_lag: 0.87 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 19:17:44.297823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:44.298261) ========= 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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.027454 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:44.389878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-18 19:17:44.390299) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1287b9f362ee36de3898ffdc09767f8ea85b2494 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1287b9f362ee36de3898ffdc09767f8ea85b2494 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0BmC3DIHs1/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.l5Kh22kh1y/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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-04-18 19:17:44,766 truncating revision to first 12 chars 2016-04-18 19:17:44,766 Setting DEBUG logging. 2016-04-18 19:17:44,766 attempt 1/10 2016-04-18 19:17:44,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1287b9f362ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 19:17:45,360 unpacking tar archive at: mozilla-aurora-1287b9f362ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842763 ========= master_lag: 5.64 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-18 19:17:50.876687) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:50.877015) ========= script_repo_revision: 1287b9f362ee36de3898ffdc09767f8ea85b2494 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 19:17:50.877395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-04-18 19:17:50.881690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-04-18 19:17:51.891376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-18 19:17:51.895667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0BmC3DIHs1/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.l5Kh22kh1y/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:17:52 INFO - MultiFileLogger online at 20160418 19:17:52 in /builds/slave/test 19:17:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:17:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:52 INFO - {'append_to_log': False, 19:17:52 INFO - 'base_work_dir': '/builds/slave/test', 19:17:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:17:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:52 INFO - 'branch': 'Mozilla-Aurora', 19:17:52 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:52 INFO - 'config_files': ('talos/mac_config.py',), 19:17:52 INFO - 'default_actions': ('clobber', 19:17:52 INFO - 'read-buildbot-config', 19:17:52 INFO - 'download-and-extract', 19:17:52 INFO - 'populate-webroot', 19:17:52 INFO - 'create-virtualenv', 19:17:52 INFO - 'install', 19:17:52 INFO - 'run-tests'), 19:17:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:52 INFO - 'download_minidump_stackwalk': True, 19:17:52 INFO - 'download_symbols': 'ondemand', 19:17:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:52 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:52 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:52 INFO - 'installer_path': 'installer.exe', 19:17:52 INFO - 'log_level': 'info', 19:17:52 INFO - 'log_name': 'talos', 19:17:52 INFO - 'log_to_console': True, 19:17:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:17:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:17:52 INFO - 'opt_config_files': (), 19:17:52 INFO - 'pip_index': False, 19:17:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:17:52 INFO - 'cmd': ('bash', 19:17:52 INFO - '-c', 19:17:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:17:52 INFO - 'enabled': True, 19:17:52 INFO - 'halt_on_failure': False, 19:17:52 INFO - 'name': 'check_screen_resolution'},), 19:17:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:17:52 INFO - 'cmd': ('bash', 19:17:52 INFO - '-c', 19:17:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:17:52 INFO - 'enabled': True, 19:17:52 INFO - 'halt_on_failure': False, 19:17:52 INFO - 'name': 'check_screen_resolution'},), 19:17:52 INFO - 'run_cmd_checks_enabled': True, 19:17:52 INFO - 'sps_profile': False, 19:17:52 INFO - 'sps_profile_interval': 0, 19:17:52 INFO - 'suite': 'dromaeojs-e10s', 19:17:52 INFO - 'system_bits': '32', 19:17:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:52 INFO - 'title': 't-yosemite-r7-0129', 19:17:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:52 INFO - 'use_talos_json': True, 19:17:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:52 INFO - 'work_dir': 'build'} 19:17:52 INFO - ##### 19:17:52 INFO - ##### Running clobber step. 19:17:52 INFO - ##### 19:17:52 INFO - Running pre-action listener: _resource_record_pre_action 19:17:52 INFO - Running main action method: clobber 19:17:52 INFO - rmtree: /builds/slave/test/build 19:17:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:17:53 INFO - Running post-action listener: _resource_record_post_action 19:17:53 INFO - ##### 19:17:53 INFO - ##### Running read-buildbot-config step. 19:17:53 INFO - ##### 19:17:53 INFO - Running pre-action listener: _resource_record_pre_action 19:17:53 INFO - Running main action method: read_buildbot_config 19:17:53 INFO - Using buildbot properties: 19:17:53 INFO - { 19:17:53 INFO - "project": "", 19:17:53 INFO - "product": "firefox", 19:17:53 INFO - "script_repo_revision": "production", 19:17:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:17:53 INFO - "repository": "", 19:17:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:17:53 INFO - "buildid": "20160418173320", 19:17:53 INFO - "pgo_build": "False", 19:17:53 INFO - "basedir": "/builds/slave/test", 19:17:53 INFO - "buildnumber": 248, 19:17:53 INFO - "slavename": "t-yosemite-r7-0129", 19:17:53 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:17:53 INFO - "platform": "yosemite_r7", 19:17:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:17:53 INFO - "branch": "mozilla-aurora", 19:17:53 INFO - "repo_path": "releases/mozilla-aurora", 19:17:53 INFO - "revision": "1287b9f362ee36de3898ffdc09767f8ea85b2494", 19:17:53 INFO - "stage_platform": "macosx64", 19:17:53 INFO - "builduid": "ce0f15b7f13645da9aea21f46dbb0eb5", 19:17:53 INFO - "slavebuilddir": "test" 19:17:53 INFO - } 19:17:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 19:17:53 INFO - Running post-action listener: _resource_record_post_action 19:17:53 INFO - ##### 19:17:53 INFO - ##### Running download-and-extract step. 19:17:53 INFO - ##### 19:17:53 INFO - Running pre-action listener: _resource_record_pre_action 19:17:53 INFO - Running main action method: download_and_extract 19:17:53 INFO - mkdir: /builds/slave/test/build/tests 19:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:53 INFO - https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 19:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 19:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 19:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 19:17:55 INFO - Downloaded 1277 bytes. 19:17:55 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 19:17:55 INFO - Using the following test package requirements: 19:17:55 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:17:55 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 19:17:55 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 19:17:55 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'jsshell-mac.zip'], 19:17:55 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 19:17:55 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:17:55 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 19:17:55 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 19:17:55 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 19:17:55 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 19:17:55 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 19:17:55 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 19:17:55 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:55 INFO - https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:17:56 INFO - Downloaded 17911050 bytes. 19:17:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:17:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:17:59 INFO - Return code: 0 19:17:59 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:17:59 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')]} 19:17:59 INFO - https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:17:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:17:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:17:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 19:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:18:01 INFO - Downloaded 17911050 bytes. 19:18:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:18:05 INFO - Return code: 0 19:18:05 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')]} 19:18:05 INFO - https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 19:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:18:06 INFO - Downloaded 10845168 bytes. 19:18:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:18:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:18:06 INFO - Return code: 0 19:18:06 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')]} 19:18:06 INFO - https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 19:18:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:18:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:18:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 19:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 19:18:09 INFO - Downloaded 115247969 bytes. 19:18:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:18:09 INFO - mkdir: /builds/slave/test/properties 19:18:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:09 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:09 INFO - Contents: 19:18:09 INFO - build_url:https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 19:18:10 INFO - Running post-action listener: _resource_record_post_action 19:18:10 INFO - Running post-action listener: set_extra_try_arguments 19:18:10 INFO - ##### 19:18:10 INFO - ##### Running populate-webroot step. 19:18:10 INFO - ##### 19:18:10 INFO - Running pre-action listener: _resource_record_pre_action 19:18:10 INFO - Running main action method: populate_webroot 19:18:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:10 INFO - '--tppagecycles', 19:18:10 INFO - '7'], 19:18:10 INFO - 'tests': ['tsvgm']}}, 19:18:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:18:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:18:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'tests': ['damp', 'tps']}, 19:18:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['damp', 'tps']}, 19:18:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:18:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:10 INFO - 'other': {'tests': ['a11yr', 19:18:10 INFO - 'ts_paint', 19:18:10 INFO - 'tpaint', 19:18:10 INFO - 'sessionrestore', 19:18:10 INFO - 'sessionrestore_no_auto_restore', 19:18:10 INFO - 'tabpaint']}, 19:18:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['a11yr', 19:18:10 INFO - 'ts_paint', 19:18:10 INFO - 'tpaint', 19:18:10 INFO - 'sessionrestore', 19:18:10 INFO - 'sessionrestore_no_auto_restore', 19:18:10 INFO - 'tabpaint']}, 19:18:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['a11yr', 19:18:10 INFO - 'ts_paint', 19:18:10 INFO - 'tpaint', 19:18:10 INFO - 'sessionrestore', 19:18:10 INFO - 'sessionrestore_no_auto_restore', 19:18:10 INFO - 'tabpaint']}, 19:18:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['a11yr', 19:18:10 INFO - 'ts_paint', 19:18:10 INFO - 'tpaint', 19:18:10 INFO - 'sessionrestore', 19:18:10 INFO - 'sessionrestore_no_auto_restore', 19:18:10 INFO - 'tabpaint']}, 19:18:10 INFO - 'other_l64': {'tests': ['a11yr', 19:18:10 INFO - 'ts_paint', 19:18:10 INFO - 'tpaint', 19:18:10 INFO - 'sessionrestore', 19:18:10 INFO - 'sessionrestore_no_auto_restore', 19:18:10 INFO - 'tabpaint']}, 19:18:10 INFO - 'other_nol64': {'tests': ['a11yr', 19:18:10 INFO - 'ts_paint', 19:18:10 INFO - 'tpaint', 19:18:10 INFO - 'sessionrestore', 19:18:10 INFO - 'sessionrestore_no_auto_restore', 19:18:10 INFO - 'tabpaint']}, 19:18:10 INFO - 'svgr': {'tests': ['tsvgx', 19:18:10 INFO - 'tsvgr_opacity', 19:18:10 INFO - 'tart', 19:18:10 INFO - 'tscrollx', 19:18:10 INFO - 'cart']}, 19:18:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['tsvgx', 19:18:10 INFO - 'tsvgr_opacity', 19:18:10 INFO - 'tart', 19:18:10 INFO - 'tscrollx', 19:18:10 INFO - 'cart']}, 19:18:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'tests': ['tp5o']}, 19:18:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'talos_options': ['--e10s'], 19:18:10 INFO - 'tests': ['tp5o']}, 19:18:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'talos_options': ['--xperf_path', 19:18:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:10 INFO - 'tests': ['tp5n']}, 19:18:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:18:10 INFO - 'talos_options': ['--e10s', 19:18:10 INFO - '--xperf_path', 19:18:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:10 INFO - 'tests': ['tp5n']}}, 19:18:10 INFO - 'talos.zip': {'path': '', 19:18:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:10 INFO - Running post-action listener: _resource_record_post_action 19:18:10 INFO - ##### 19:18:10 INFO - ##### Running create-virtualenv step. 19:18:10 INFO - ##### 19:18:10 INFO - Running pre-action listener: _resource_record_pre_action 19:18:10 INFO - Running main action method: create_virtualenv 19:18:10 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18:10 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 19:18:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:10 INFO - Using real prefix '/tools/python27' 19:18:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:11 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:13 INFO - Installing pip.................done. 19:18:13 INFO - Return code: 0 19:18:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18: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', 'pip>=1.5'] in /builds/slave/test/build 19:18: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 pip>=1.5 19:18:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:13 INFO - 'HOME': '/Users/cltbld', 19:18:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:13 INFO - 'LOGNAME': 'cltbld', 19:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:13 INFO - 'MOZ_NO_REMOTE': '1', 19:18:13 INFO - 'NO_EM_RESTART': '1', 19:18:13 INFO - 'PAGER': '/bin/cat', 19:18:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:13 INFO - 'PWD': '/builds/slave/test', 19:18:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:13 INFO - 'SHELL': '/bin/bash', 19:18:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:13 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:13 INFO - 'USER': 'cltbld', 19:18:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:13 INFO - 'XPC_FLAGS': '0x0', 19:18:13 INFO - 'XPC_SERVICE_NAME': '0', 19:18:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:14 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 19:18:14 INFO - Cleaning up... 19:18:14 INFO - Return code: 0 19:18:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:14 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:14 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 19:18:14 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 19:18:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:14 INFO - 'HOME': '/Users/cltbld', 19:18:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:14 INFO - 'LOGNAME': 'cltbld', 19:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:14 INFO - 'MOZ_NO_REMOTE': '1', 19:18:14 INFO - 'NO_EM_RESTART': '1', 19:18:14 INFO - 'PAGER': '/bin/cat', 19:18:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:14 INFO - 'PWD': '/builds/slave/test', 19:18:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:14 INFO - 'SHELL': '/bin/bash', 19:18:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:14 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:14 INFO - 'USER': 'cltbld', 19:18:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:14 INFO - 'XPC_FLAGS': '0x0', 19:18:14 INFO - 'XPC_SERVICE_NAME': '0', 19:18:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:14 INFO - Downloading/unpacking psutil>=0.7.1 19:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:17 INFO - Installing collected packages: psutil 19:18:17 INFO - Running setup.py install for psutil 19:18:17 INFO - building 'psutil._psutil_osx' extension 19:18:17 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 19:18:18 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 19:18:18 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 19:18:18 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 19:18:18 INFO - building 'psutil._psutil_posix' extension 19:18:18 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 19:18:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:18:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:18:18 INFO - ^ 19:18:18 INFO - 1 warning generated. 19:18:18 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 19:18:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:18 INFO - Successfully installed psutil 19:18:18 INFO - Cleaning up... 19:18:18 INFO - Return code: 0 19:18:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:18:18 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')]} 19:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:18 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')]} 19:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:18 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:18 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 19:18:18 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 19:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:18 INFO - 'HOME': '/Users/cltbld', 19:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:18 INFO - 'LOGNAME': 'cltbld', 19:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:18 INFO - 'MOZ_NO_REMOTE': '1', 19:18:18 INFO - 'NO_EM_RESTART': '1', 19:18:18 INFO - 'PAGER': '/bin/cat', 19:18:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:18 INFO - 'PWD': '/builds/slave/test', 19:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:18 INFO - 'SHELL': '/bin/bash', 19:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:18 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:18 INFO - 'USER': 'cltbld', 19:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:18 INFO - 'XPC_FLAGS': '0x0', 19:18:18 INFO - 'XPC_SERVICE_NAME': '0', 19:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:18:18 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 19:18:18 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 19:18:18 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 19:18:18 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 19:18:18 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 19:18:18 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 19:18:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:18:21 INFO - Installing collected packages: mozsystemmonitor 19:18:21 INFO - Running setup.py install for mozsystemmonitor 19:18:21 INFO - Successfully installed mozsystemmonitor 19:18:21 INFO - Cleaning up... 19:18:21 INFO - Return code: 0 19:18:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:21 INFO - 'HOME': '/Users/cltbld', 19:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:21 INFO - 'LOGNAME': 'cltbld', 19:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:21 INFO - 'MOZ_NO_REMOTE': '1', 19:18:21 INFO - 'NO_EM_RESTART': '1', 19:18:21 INFO - 'PAGER': '/bin/cat', 19:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:21 INFO - 'PWD': '/builds/slave/test', 19:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:21 INFO - 'SHELL': '/bin/bash', 19:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:21 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:21 INFO - 'USER': 'cltbld', 19:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:21 INFO - 'XPC_FLAGS': '0x0', 19:18:21 INFO - 'XPC_SERVICE_NAME': '0', 19:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:24 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18: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 19:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:25 INFO - Downloading docopt-0.6.1.tar.gz 19:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:25 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:25 INFO - Running setup.py install for blobuploader 19:18:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:25 INFO - Running setup.py install for requests 19:18:26 INFO - Running setup.py install for docopt 19:18:26 INFO - Successfully installed blobuploader requests docopt 19:18:26 INFO - Cleaning up... 19:18:26 INFO - Return code: 0 19:18:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:26 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:26 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 19:18:26 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 19:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:26 INFO - 'HOME': '/Users/cltbld', 19:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:26 INFO - 'LOGNAME': 'cltbld', 19:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:26 INFO - 'MOZ_NO_REMOTE': '1', 19:18:26 INFO - 'NO_EM_RESTART': '1', 19:18:26 INFO - 'PAGER': '/bin/cat', 19:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:26 INFO - 'PWD': '/builds/slave/test', 19:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:26 INFO - 'SHELL': '/bin/bash', 19:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:26 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:26 INFO - 'USER': 'cltbld', 19:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:26 INFO - 'XPC_FLAGS': '0x0', 19:18:26 INFO - 'XPC_SERVICE_NAME': '0', 19:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-y7QnK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-tFK_gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:26 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-IxZwpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-TnpSuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-aYv_tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-CEtc6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-MKmIWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-Y0QLyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-3A_k_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-o70S06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-yqaojv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-e19r8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:27 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-NRxsKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:28 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-CZrrow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:28 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-gH8DAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:28 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-D3CPix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:28 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-lA0_em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:28 INFO - Running setup.py install for manifestparser 19:18:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:28 INFO - Running setup.py install for mozcrash 19:18:28 INFO - Running setup.py install for mozdebug 19:18:28 INFO - Running setup.py install for mozdevice 19:18:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Running setup.py install for mozfile 19:18:29 INFO - Running setup.py install for mozhttpd 19:18:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Running setup.py install for mozinfo 19:18:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Running setup.py install for mozInstall 19:18:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Running setup.py install for mozleak 19:18:29 INFO - Running setup.py install for mozlog 19:18:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:29 INFO - Running setup.py install for moznetwork 19:18:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:30 INFO - Running setup.py install for mozprocess 19:18:30 INFO - Running setup.py install for mozprofile 19:18:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:30 INFO - Running setup.py install for mozrunner 19:18:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:30 INFO - Running setup.py install for mozscreenshot 19:18:30 INFO - Running setup.py install for moztest 19:18:30 INFO - Running setup.py install for mozversion 19:18:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:30 INFO - Cleaning up... 19:18:31 INFO - Return code: 0 19:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:31 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:31 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 19:18:31 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 19:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:31 INFO - 'HOME': '/Users/cltbld', 19:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:31 INFO - 'LOGNAME': 'cltbld', 19:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:31 INFO - 'MOZ_NO_REMOTE': '1', 19:18:31 INFO - 'NO_EM_RESTART': '1', 19:18:31 INFO - 'PAGER': '/bin/cat', 19:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:31 INFO - 'PWD': '/builds/slave/test', 19:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:31 INFO - 'SHELL': '/bin/bash', 19:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:31 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:31 INFO - 'USER': 'cltbld', 19:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:31 INFO - 'XPC_FLAGS': '0x0', 19:18:31 INFO - 'XPC_SERVICE_NAME': '0', 19:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-WaqTla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:31 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)) 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-uq55xB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:31 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)) 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-YJzXbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:31 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)) 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-ea0nvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:31 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)) 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-PqO9Sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:31 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)) 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-1n9AGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:31 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)) 19:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:31 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-AtqJFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-kcWJ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-HkoDfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-2H8jfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-vWCsal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-ZC9B6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-NZprIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-fz2yGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-N1FoOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-aTAuON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:32 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)) 19:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:32 INFO - Running setup.py (path:/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/pip-605MhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:33 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)) 19:18:33 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)) 19:18:33 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)) 19:18:33 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)) 19:18:33 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)) 19:18:33 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)) 19:18:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:33 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 19:18:33 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 19:18:33 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 19:18:33 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 19:18:33 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 19:18:33 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 19:18:35 INFO - Downloading blessings-1.6.tar.gz 19:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:35 INFO - Installing collected packages: blessings 19:18:35 INFO - Running setup.py install for blessings 19:18:35 INFO - Successfully installed blessings 19:18:35 INFO - Cleaning up... 19:18:35 INFO - Return code: 0 19:18:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:36 INFO - Reading from file tmpfile_stdout 19:18:36 INFO - Current package versions: 19:18:36 INFO - blessings == 1.6 19:18:36 INFO - blobuploader == 1.2.4 19:18:36 INFO - docopt == 0.6.1 19:18:36 INFO - manifestparser == 1.1 19:18:36 INFO - mozInstall == 1.12 19:18:36 INFO - mozcrash == 0.17 19:18:36 INFO - mozdebug == 0.1 19:18:36 INFO - mozdevice == 0.48 19:18:36 INFO - mozfile == 1.2 19:18:36 INFO - mozhttpd == 0.7 19:18:36 INFO - mozinfo == 0.9 19:18:36 INFO - mozleak == 0.1 19:18:36 INFO - mozlog == 3.1 19:18:36 INFO - moznetwork == 0.27 19:18:36 INFO - mozprocess == 0.22 19:18:36 INFO - mozprofile == 0.28 19:18:36 INFO - mozrunner == 6.11 19:18:36 INFO - mozscreenshot == 0.1 19:18:36 INFO - mozsystemmonitor == 0.0 19:18:36 INFO - moztest == 0.7 19:18:36 INFO - mozversion == 1.4 19:18:36 INFO - psutil == 3.1.1 19:18:36 INFO - requests == 1.2.3 19:18:36 INFO - wsgiref == 0.1.2 19:18:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:36 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')]} 19:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:36 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')]} 19:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:36 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:36 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 19:18:36 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 19:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:36 INFO - 'HOME': '/Users/cltbld', 19:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:36 INFO - 'LOGNAME': 'cltbld', 19:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:36 INFO - 'MOZ_NO_REMOTE': '1', 19:18:36 INFO - 'NO_EM_RESTART': '1', 19:18:36 INFO - 'PAGER': '/bin/cat', 19:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:36 INFO - 'PWD': '/builds/slave/test', 19:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:36 INFO - 'SHELL': '/bin/bash', 19:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:36 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:36 INFO - 'USER': 'cltbld', 19:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:36 INFO - 'XPC_FLAGS': '0x0', 19:18:36 INFO - 'XPC_SERVICE_NAME': '0', 19:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 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)) 19:18:36 INFO - Cleaning up... 19:18:36 INFO - Return code: 0 19:18:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:36 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')]} 19:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:36 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')]} 19:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:36 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:36 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 19:18:36 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 19:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:36 INFO - 'HOME': '/Users/cltbld', 19:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:36 INFO - 'LOGNAME': 'cltbld', 19:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:36 INFO - 'MOZ_NO_REMOTE': '1', 19:18:36 INFO - 'NO_EM_RESTART': '1', 19:18:36 INFO - 'PAGER': '/bin/cat', 19:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:36 INFO - 'PWD': '/builds/slave/test', 19:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:36 INFO - 'SHELL': '/bin/bash', 19:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:36 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:36 INFO - 'USER': 'cltbld', 19:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:36 INFO - 'XPC_FLAGS': '0x0', 19:18:36 INFO - 'XPC_SERVICE_NAME': '0', 19:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:36 INFO - Downloading/unpacking jsonschema 19:18:36 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 19:18:36 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 19:18:36 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 19:18:36 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 19:18:36 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 19:18:36 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 19:18:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:38 INFO - Downloading/unpacking functools32 (from jsonschema) 19:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:39 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:39 INFO - warning: no files found matching '*.txt' 19:18:39 INFO - no previously-included directories found matching 'build' 19:18:39 INFO - no previously-included directories found matching 'dist' 19:18:39 INFO - no previously-included directories found matching '.git*' 19:18:39 INFO - Installing collected packages: jsonschema, functools32 19:18:39 INFO - Running setup.py install for functools32 19:18:39 INFO - warning: no files found matching '*.txt' 19:18:39 INFO - no previously-included directories found matching 'build' 19:18:39 INFO - no previously-included directories found matching 'dist' 19:18:39 INFO - no previously-included directories found matching '.git*' 19:18:39 INFO - Successfully installed jsonschema functools32 19:18:39 INFO - Cleaning up... 19:18:39 INFO - Return code: 0 19:18:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:18:39 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')]} 19:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:39 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')]} 19:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:39 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 0x105d40a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d474c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1dad9a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, '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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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 19:18:39 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 19:18:39 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 19:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:18:39 INFO - 'HOME': '/Users/cltbld', 19:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:18:39 INFO - 'LOGNAME': 'cltbld', 19:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:39 INFO - 'MOZ_NO_REMOTE': '1', 19:18:39 INFO - 'NO_EM_RESTART': '1', 19:18:39 INFO - 'PAGER': '/bin/cat', 19:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:39 INFO - 'PWD': '/builds/slave/test', 19:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:18:39 INFO - 'SHELL': '/bin/bash', 19:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:18:39 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:18:39 INFO - 'USER': 'cltbld', 19:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:39 INFO - 'XPC_FLAGS': '0x0', 19:18:39 INFO - 'XPC_SERVICE_NAME': '0', 19:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:39 INFO - Downloading/unpacking flake8 19:18:39 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 19:18:39 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 19:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:18:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:18:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 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 19:18:42 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 19:18:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:18:43 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 19:18:43 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 19:18:43 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 19:18:43 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 19:18:43 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 19:18:43 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 19:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:18:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:18:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:18:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:18:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:18:43 INFO - no previously-included directories found matching 'docs/_build' 19:18:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:18:43 INFO - Running setup.py install for pep8 19:18:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:18:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:18:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:18:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:18:43 INFO - no previously-included directories found matching 'docs/_build' 19:18:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:18:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:18:43 INFO - Cleaning up... 19:18:43 INFO - Return code: 0 19:18:43 INFO - Running post-action listener: _resource_record_post_action 19:18:43 INFO - Running post-action listener: _start_resource_monitoring 19:18:44 INFO - Starting resource monitoring. 19:18:44 INFO - ##### 19:18:44 INFO - ##### Running install step. 19:18:44 INFO - ##### 19:18:44 INFO - Running pre-action listener: _resource_record_pre_action 19:18:44 INFO - Running main action method: install 19:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:44 INFO - Reading from file tmpfile_stdout 19:18:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:44 INFO - Reading from file tmpfile_stdout 19:18:44 INFO - Output received: 19:18:44 INFO - Usage: mozinstall [options] installer 19:18:44 INFO - Options: 19:18:44 INFO - -h, --help show this help message and exit 19:18:44 INFO - -d DEST, --destination=DEST 19:18:44 INFO - Directory to install application into. [default: 19:18:44 INFO - "/builds/slave/test"] 19:18:44 INFO - --app=APP Application being installed. [default: firefox] 19:18:44 INFO - mkdir: /builds/slave/test/build/application 19:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:19:15 INFO - Reading from file tmpfile_stdout 19:19:15 INFO - Output received: 19:19:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:19:15 INFO - Running post-action listener: _resource_record_post_action 19:19:15 INFO - ##### 19:19:15 INFO - ##### Running run-tests step. 19:19:15 INFO - ##### 19:19:15 INFO - Running pre-action listener: _resource_record_pre_action 19:19:15 INFO - Running main action method: run_tests 19:19:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:15 INFO - 2016-04-18 19:19:15.942 screenresolution[1637:7699] starting screenresolution argv=screenresolution get 19:19:15 INFO - 2016-04-18 19:19:15.945 screenresolution[1637:7699] Display 0: 1600x1200x32@60 19:19:15 INFO - 2016-04-18 19:19:15.950 screenresolution[1638:7701] starting screenresolution argv=screenresolution list 19:19:15 INFO - Available Modes on Display 0 19:19:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:16 INFO - Intel Iris: 19:19:16 INFO - Chipset Model: Intel Iris 19:19:16 INFO - Type: GPU 19:19:16 INFO - Bus: Built-In 19:19:16 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:16 INFO - Vendor: Intel (0x8086) 19:19:16 INFO - Device ID: 0x0a2e 19:19:16 INFO - Revision ID: 0x0009 19:19:16 INFO - Displays: 19:19:16 INFO - Display: 19:19:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:16 INFO - Display Serial Number: 1600x1200 60 19:19:16 INFO - Main Display: Yes 19:19:16 INFO - Mirror: Off 19:19:16 INFO - Online: Yes 19:19:16 INFO - Rotation: Supported 19:19:16 INFO - Return code: 0 19:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:16 INFO - Python 2.7.3 19:19:16 INFO - Return code: 0 19:19:16 INFO - grabbing minidump binary from tooltool 19:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:19:16 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 0x105be4d30>, '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 0x105a48db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bdbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:16 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 19:19:16 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 19:19:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:16 INFO - Return code: 0 19:19:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:19:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:19:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:19:17 INFO - Return code: 0 19:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 19:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0129 --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 19:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BmC3DIHs1/Render', 19:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:17 INFO - 'HOME': '/Users/cltbld', 19:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:17 INFO - 'LOGNAME': 'cltbld', 19:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:17 INFO - 'MOZ_NO_REMOTE': '1', 19:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:17 INFO - 'NO_EM_RESTART': '1', 19:19:17 INFO - 'PAGER': '/bin/cat', 19:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:17 INFO - 'PWD': '/builds/slave/test', 19:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:17 INFO - 'SHELL': '/bin/bash', 19:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l5Kh22kh1y/Listeners', 19:19:17 INFO - 'TMPDIR': '/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/', 19:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:17 INFO - 'USER': 'cltbld', 19:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:17 INFO - 'XPC_FLAGS': '0x0', 19:19:17 INFO - 'XPC_SERVICE_NAME': '0', 19:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0129', '--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 19:19:17 INFO - mozversion application_buildid: 20160418173320 19:19:17 INFO - mozversion application_changeset: 1287b9f362ee36de3898ffdc09767f8ea85b2494 19:19:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:17 INFO - mozversion application_name: Firefox 19:19:17 INFO - mozversion application_remotingname: firefox-dev 19:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:19:17 INFO - mozversion application_vendor: Mozilla 19:19:17 INFO - mozversion application_version: 47.0a2 19:19:17 INFO - mozversion platform_buildid: 20160418173320 19:19:17 INFO - mozversion platform_changeset: 1287b9f362ee36de3898ffdc09767f8ea85b2494 19:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:19:17 INFO - mozversion platform_version: 47.0a2 19:19:17 INFO - using testdate: 1461032357 19:19:17 INFO - actual date: 1461032357 19:19:17 INFO - starting webserver on 'localhost:49275' 19:19:17 INFO - SUITE-START | Running 2 tests 19:19:17 INFO - TEST-START | dromaeo_css 19:19:17 INFO - operating with platform_type : mac_ 19:19:17 INFO - Initialising browser for dromaeo_css test... 19:19:17 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpeSTqT6/profile http://localhost:49275/getInfo.html) 19:19:20 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 19:19:20 INFO - PROCESS | 1656 | colorDepth:24 19:19:20 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 19:19:20 INFO - PROCESS | 1656 | __metrics 19:19:20 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:19:21 INFO - TEST-INFO | 1656: exit 0 19:19:21 INFO - Browser initialized. 19:19:21 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:21 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmpeSTqT6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:33 INFO - PROCESS | 1659 | RSS: Main: 217358336 19:19:33 INFO - PROCESS | 1659 | 19:20:23 INFO - PROCESS | 1659 | 1461032423061 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] 19:22:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 19:22:35 INFO - PROCESS | 1659 | RSS: Main: 228134912 19:22:35 INFO - PROCESS | 1659 | 19:25:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 19:25:38 INFO - PROCESS | 1659 | RSS: Main: 239927296 19:25:38 INFO - PROCESS | 1659 | 19:28:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 19:28:40 INFO - PROCESS | 1659 | RSS: Main: 242573312 19:28:40 INFO - PROCESS | 1659 | 19:31:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 19:31:42 INFO - PROCESS | 1659 | RSS: Main: 243515392 19:31:42 INFO - PROCESS | 1659 | 19:34:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 19:34:46 INFO - PROCESS | 1659 | RSS: Main: 247177216 19:34:46 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 19:37:48 INFO - PROCESS | 1659 | RSS: Main: 247623680 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | __start_tp_report 19:37:48 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 19:37:48 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 19:37:48 INFO - PROCESS | 1659 | |i|pagename|runs| 19:37:48 INFO - PROCESS | 1659 | |0;dojo.html;3552.484889690995;3564.322778672052;3591.694705949994;3622.474741162531;3644.9976256529453;5937.079752638338;5941.792037278696;5970.373110823366;5977.5815692901515;5991.910121348173;5932.406759324065;6006.159137720711;6009.338972713009;6009.519238460924;6024.819255422344;5295.391030031538;5336;5435.021696094701;5478.534324582415;5516.062269414209;5278.155495120782;5369.543588794957;5372.355317361922;5400.405955344909;5405.324334458192;5424.945750542503;5432.619716619838;5469.425710300421;5469.808556700516;5476.17857321401;5404.378496472897;5417.51242388183;5435.374931882845;5449.700266485342;5451.454854514556;5165.74171291434;5186.636935414523;5300.628955973083;5371.113766228606;5429.375621803503;4851.902961940777;5763.769449222026;5893.322267939199;5911.379305172938;5927.614705044159;5971.8056388722425;6367.968160159216;6389.808305750788;6398.104265402847;6402.839929001766;6045.576809623328;6457.806265812033;6462.90305645411;6478.384553467413;6516.0877477153235;4907.386576677915;5802.912956305574;6092.817215483543;6113.572049956505;6122.602030867979;5485.314335708036;6419.614823110628;6478.935210647834;6582.868342633121;6584.275729669733;6234.37656234382;6266.655333956585;6284.717187726564;6290.8427289317215;6301.747930082837;6397.200349956255;6402;6433.388828061326;6446.129772480749;6450.838729031718;5384.784608615611;6148;6290.025046117859;6292.307846136921;6310;5017.347744793154;6292.716827742763;6321.683915804283;6361.522885783585;6366.299707032223;4777.546133117348;5058.595312375001;5083.135866902636;5116.56509196715;5125.692458452505;3463.7229021678204;4449.688521803508;4572.154151481986;4612.86161415158;4624.28323609841;5911.290645122527;5975.731092100866;6072.453479186895;6082.482988945901;6091.0558863376245;6433.967830160819;6448.484121270287;6457.773977910751;6463.353664633593;6481.675916204171;5938.49522790559;5982.282126144891;6074.848128796815;6079.179310793074;6125.571210015345;4684.367610372624;5533.695646739468;5577.888442231133;5582.385937546866;5587.217789509472;6502.934970650233;6619.205695316593;6639.734410623618;6657.300983396771;6689.5986240825705;6268.717907694256;6368.395002474757;6404.743810247538;6417.839554011187;6496.350364963466;6673.032410300382;6692.330766923464;6694.230163531061;6717.227518835396;6724.865502689821;6230.7507699691505;6392.232932048184;6398.104265402941;6416.679166041586;6426.196725409324;4683.758803916897;6091.847703807441;6329.208848893888;6363.395477429637;6381.074744162163;6225.595336303126;6232.844178895564;6254.3745625437095;6264.655443950626;6310.148130002391;6132.877342453036;6208.875822483616;6285.2457705075685;6298.433141017331;6302;5412.675239485643;5513.897220555985;6118.649636126507;6232.5948813328805;6246.219222597176;5228.346456692913;6260.499160067093;6264.404881536247;6270.184875966095;6280.654563999024;6110.103144028831;6127.325994140552;6169.96915015422;6240.157578726814;6253.6560489173535 19:37:48 INFO - PROCESS | 1659 | |1;ext.html;454.5409136771859;584.3484514766037;616.2020183861898;675.9725217669143;677.8882632482728;31873;39937;40004.39993400101;40115.39826902595;40287.597124028754;41628;41794.791026044826;42431.57568424315;42480.57519424805;42502;9597.999999999982;9789.804203915917;9796.804063918717;9836.803263934717;9874.061964113398;9686.128248457637;9793.363431376973;9845.11393974542;9916.206703463706;9963.053509916546;8719.782005449852;9603.18372938301;9871.802563948717;9872.35829671069;9956.452395118265;9811.607535698598;9877.851832222523;9891.653792117277;9914.752131196778;9920.156786673142;9718.951405242999;9814.509274536245;9825.950870245602;9874.111329980336;9876.703698889045;34075;37035.07412314687;40787;40993;41226.58773412257;3144.4497212987635;3275.918102047444;3350.2294472271515;3419.760616756828;3688.354537955847;23033.19383821575;28139;28251;28694;29031.70968290311;2604.101584953207;2808.5506318988864;2810.423863108058;2813.943721125566;2836.347640042781;345548;371067;372408.1379593112;373494;445966.99999999674;47937.80155496141;48534.786630333816;49191.754041230284;67434.66282668556;68081.97877031848;47664.761676191396;47864.56406307816;47903.76048119737;48204.27693584599;48377.758111209216;16557.337706491606;17277.82722172762;17278.481645550655;17452.301907923542;17499.65000699979;12309.93845030769;13275.606061363418;13753.587392378246;13863.445462181602;13980;15616.3753449863;15705.293261803246;15754.9212253938;15791.763123553155;15799.289031993589;6595.934040659532;6706.161729783777;6712.664366781642;6726.360995705498;6754.290799466084;788.6648174525918;1002.979940401188;1053.3153450257394;1068.1027936533349;1165.9972423715599;30279.243018924262;30405.78376864945;30460.847695761822;30691.232719181753;30843.38313233723;1102.779444111181;1116.151724689242;1146.9139814513944;1156.7108222944264;1160.9187356885107;15561.610959726097;15609.531714048597;15663.608409789846;15670.686586268212;15875.20623968797;532853;541594;542632;545688;547841;60322.698386507785;61117.69441152766;61722.074168887506;62096.68951655303;62310;1504.0674781635455;1506.6459382045211;1516.1433789908447;1528.3733669195576;1537.5541093082882;29969.400611988076;30760.923367682022;31502.684973149975;32031.519527207576;32812;56599.15101273567;56729.432705672414;56905.57736056632;57401.42598573961;57482.85034299207;518488;519754;522114;523307;524300;44082.118357633306;44831.87920302019;46194.769026156;46429.3035604473;47018.529814702786;47769.28346074881;48020;48567.27149092837;49145;49891.25163122629;39388.803055984536;39589;40402;40428.393574097;40888.1822363557;38002;38203.80898095492;38483.80758096192;38746;39114.60885391109;38530;39012;39438.80280598579;40040.3993940097;40057.39913901352;31245.218869528442;33287.334253314315;33440;33445.33109337751;33531.4970275451;21158.259460918795;24922.750772492043;25727.228183154537;33517.66482335146;33666.663333366356 19:37:48 INFO - PROCESS | 1659 | |2;jquery.html;359.5182455509617;365.2202547560958;370.944358346248;374.12641482139196;381.49832969644933;20643;21871.890640546815;22018.44953876152;22254.666180007294;22749.658755118686;20431.591368172627;20501.07745151468;20741.06665200066;21184.89407552964;21304.4673883153;5874.70626468677;6051.6671583063135;6075.574709770318;6093.756249750027;6097.05495648173;4075.735077219986;5693.857653558653;5838;5955.553333499983;6092.390760923917;5217.243499692542;6051.243594550681;6076.3316035236085;6081.665508397036;6093.603915745484;5854.853628659296;6615.569987950767;6621.635810030446;6643.9003414948575;6650.1022361980995;5662.518685911702;5824.796132135355;5833.387494313079;5850.180974663551;5870.20752198452;10722.839157412645;13649.249291288976;13968.790468142986;13974.161550306913;14024.929875350557;2127.712758777561;2288.7088049783874;2299.5745787029286;2532.898684052654;2565.268898363976;9810.803783924353;9946.602135914554;9959.950200248952;10334.224933130045;10593.523291451904;1732.1166205235295;1748.8950662960262;1779.9377021804175;1798.640271945603;1805.783306003288;105946.47026764817;113686.43156784163;116894;116981;118862;11330.09359251258;11597.478113484913;11608;11675.124365672438;11682.532698692126;12013.699657508458;14154.64613384653;14321.427142914376;14330.49843255481;14349.995500314877;7554.2823431773895;8780.736577902673;8937.46375217476;9091.909080909238;9094.81810363789;9348.626054957726;9362.625494980124;9364.438133712;9365.672201472917;9454.101860323259;3729.310077635646;4358.433403657567;4533.116042371772;4592.494825569252;4603.516630753789;1787.374418953382;1841.9316796258406;1891.498752830501;1940.5827747034455;1943.6987266973642;726.3970904149543;885.9911400886037;930.6040938592112;987.1855719031828;1029.8558201851747;16378.896882493957;20404.897975510026;20662.483437914172;21143.471413214484;21178.94105294729;997.8154041502345;1001.979960400788;1003.087190656499;1017.7252141921788;1020.642775028734;10782.299150555189;10999.120070394349;11290.885346572153;11362.659120226406;11396;639049;644147;651195;658366;660110;90210.74473138092;108197.91802082036;121167.39416302861;133007;138996.61003389835;1029.5161274201114;1055.4828134214333;1060.183658582887;1063.42575009494;1079.881213066562;16139.515814525583;17436.389726359517;18366.540836479195;18462.538436538656;19140.23439062422;52398.95202096013;54333.72833135809;54885;57626.71186644208;57755.71122144363;57380.71309643425;72503.63748181437;84331.15668843478;84582;86889.56555217183;7216.7474138404905;7907.920920790719;8040.39697022714;8324.833503329779;8462.19609137131;11120.555177793121;12950.352482375654;13850.861491384958;13903.374348154155;14286.214258215898;9059.867516560429;10764.3541387517;10992.010719035325;12062.577809776616;12085.758284834079;11817.645470635895;11922.880771192524;11930.940345298219;11965.461554229907;11974.22167559106;12054.337011464102;12128.272303661808;12134.878651213729;12300.81548776787;12366.134370593973;7974.242446967529;8123.83752324962;8214.794630134056;8227.629756660845;8645.394822362374;8722.651093956425;11672.358020308964;11921.225120367495;11948.044156467287;12069.155159139127 19:37:48 INFO - PROCESS | 1659 | |3;mootools.html;1591.323687432841;1591.8408159184082;1888.6978083506633;1982.3458258774606;1983.960320793585;6746.62893540855;8831.779205519866;8845.248153906918;9059.365844390895;9076.773080672978;8852.291816654668;8877.334199935014;8990.190882820561;9000.324975626821;9027.14242146995;2504.987475062627;2508.3227528567277;2509.0967251789343;2520.5085008423366;2526.3305224115625;2494.625806129077;2551.7065537463245;2554.7062087859854;2559.718430972601;2567.242663414297;2538.0862889359814;2544.643749875019;2566.101864347482;2568.126836875462;2577.9742202578013;2526.684164479431;2545.185540627;2557.3350928758473;2559.296193546771;2569.0622922633197;2519.5212909547313;2526.9620955685496;2536.6321883326814;2542.7711505964553;2566.8716564171905;9084.09159084093;9092.8636070459;9153.267738580898;9154.542272886396;9155.725328240163;5536.916946245809;5621.550275977912;5670.518005969498;5683.914741278884;5708.600397972144;3619.2037751694584;3674.595794462607;3697.7411581189326;3746.4754934309217;3754.0239537720117;1051.9737006574896;1067.9946600267026;1080.4111759091313;1086.9456527173609;1087.9782404351947;12178.208416452902;12244.326562039085;12336.938315308456;12350.876491235153;12368.752624947541;4456.487503937024;4478.39541661878;4983.651144419929;5054.82308119214;5060.544550990355;10163.034511721375;10204.591816327264;10370;10416.114630256361;10438.269321147598;5589.636673616284;5615.185798059259;5621.0444224481935;5626.943730562723;5665.12190610456;4524.411826462539;4994.150994330972;5057;5069.9746501267255;5086.643934924594;4069.8251394319373;4114.259433301974;4119.382092686061;4129.648979836687;4136.96575856036;1212.5452955141823;1297.5588299978053;1352.0670737191306;1360.415021540747;1367.3591689972072;1389.062382891544;1403.6280385697798;1409.6828213652052;1444.0830072903782;1446.3636000159895;7111.395531379787;8213;8295.709650162215;8430.072692003874;8457.957710211409;443.8912466445677;450.92559727645227;531.7288183026684;534.9144136938071;535.7883635963773;5310.893782124336;6232.56372053961;6268.686565671698;6270.467010304084;6328.430441260217;10492.475376231157;11054.889451105386;11093.83359249612;11131.276467029616;11177.608783692533;8759.60581773809;10793.568257269779;10922.071623912056;10929;10933.835992460119;8431.241188293083;8434.915650843413;8474.957625211835;8544.743657690155;8550.828983420297;8108.594570271581;8218.178182181973;8259.21537453941;8293.460925039853;8366.665333386596;9581.712548623553;9740.318177727491;9805.901940980784;9833.16418104469;9857.408555486694;8130.512169269863;8785.165409286108;9677.645129681709;10045.598176072876;10337.483125843528;6983.860322793617;7380.298871607189;7632.236776322324;7734.961325193338;7845.5684937329;7740.109887363025;8384.874226886479;8416.3266938646;8452.197041281068;8458.40791144614;6875.5530890491955;7412.369948554433;7519.097708275042;7626.351760100453;7629.046369203849;7287.963560182166;7307.7807665770115;7381.8154546136775;7392.4086073115095;7408.9629551851895;7988.8002799928145;8003.319717823817;8006.279434850891;8023.598820058857;8054.5569993650915;7122.60825654594;7227.819304517429;7265.9273407265255;7269.1640461345505;7286.781396558112;7250.528715633467;7333.193348731528;7339.412846972123;7381.077365329334;7395.445341599294 19:37:48 INFO - PROCESS | 1659 | |4;prototype.html;292.9619149510563;341.411065911303;342.23851929456947;343.6048544174199;349.09061893766744;5920.81583683264;6484.578502397341;6837.863242735149;6876.484263680225;6890.931905554641;6820.567680787029;6829.692663830139;6845.828854278646;6852.897206541893;6895.034695142672;4765.261384485393;4900.264960255972;4955.6035517158725;4970.900581988358;5049.040682270375;4997.275395067732;5004.349434573501;5026.095302845504;5059.974700126494;5074.695518268897;4990.076835785373;4998.375203099613;5000.499950005007;5005.0990821652085;5021.322121513604;4277.930517370657;4981.72600506972;5005.874853128665;5010.023045506127;5030.57240134589;4144.4197812306;4317.525072242082;4327.199468098412;4330.2638551446325;4333.8699839004885;6320.62076275425;6613.735450581971;6642.036904648847;6677.065210870482;6692.397684208396;4516.841910533149;5198.246254293144;5833.941660583425;5850.327212370589;5885.470307672287;6695;7309.451791115687;7313.597752123631;7314.5611263323835;7344.192138864721;4667.6265898728025;4675.228587283094;4686.133065382915;4689.062187562501;4695.67130300879;7308.086489188904;7638.121616014174;7676.7313144040245;7720.691172353156;7731.690732370755;4530.773461326987;4638.536146385402;4745.3593764842;4773.069251495925;4786.856394308176;4849.248366503198;4859.854204373874;4870.6103511718975;4875.975620121877;4908.582770464479;5786.421357864264;5844.9415505845245;5858.238429004202;5866.413358664185;5883.17635531026;7325.267473252632;7337.559746415232;7340.37606803417;7341.926580734124;7370.078740157481;1598.5444148417646;1636.3291050669168;1643.2030465224357;1665.5170000699661;1676.773635559184;1052.0899422000068;1060.931039482431;1073.608133031438;1079.3254216114929;1079.8920107989138;6677.23211830636;6952.791416257521;6959.338862808025;6978.825529361807;7000.26497217795;7573.9242607573215;7582.658780354897;7586.468947173756;7604.2395760423515;7613.276738709814;6752.291009444036;6778.76274330406;6814.8296292592095;6817.5568588041615;6818.113645226089;3208.775385722977;3671.4676371926457;3989.6209860063245;4012.578679238696;4024.054347228399;7802.180771019075;7878.448508604457;7939.603019848984;7988.320992715568;8000.599970001476;6489.156409666807;7750.7674769756995;7882.842343153105;7899.407544434191;7916.643751031217;7932.246436588515;7934.920650793418;7962.482438641469;8004.359651227888;8179.754607361789;7333.779986600411;7558.093028836574;7624.390048796194;7662.846743064996;7749.7675069748;5963.4334738199805;7440;7469.290417410337;7514.849703006019;7528.585927773806;6792.675428291634;7738.993930788962;8052.5571093590415;8092.271695547429;8100.0684921234815;4719.9852031813325;4772.164871147465;4778.761061946958;4793.23308270675;4807.846116931842;7368.447366447431;7539.095308563007;7630.313271805564;7635.350995165473;7668.57822819728;7294.234105418855;7299.817504562428;7304.904264360389;7411.8147046324275;7439.256074392518;5801.6519008859605;7413.777586672409;7424.331810137113;7430.405567554474;7433.851322973402;5879.7060146993335;6494.935050649622;6785.541108661661;7221.097362829646;7243.420526357984;7131.25121862197;7456.366208872307;7470.252974702486;7470.4770666052855;7488.9625551871895;7188.9640551799;7270.781876543712;7282.12614486265;7289.927100728924;7304.233055529306 19:37:48 INFO - PROCESS | 1659 | |5;yui.html;709.4678990756933;766.1227894061303;766.3983772738402;773.9458237923346;788.9053313602369;15148.77276840847;15471.92264038681;15584.220788960549;15599.610009749762;15601.531954041397;14422.206778627198;14631.41474341025;14655.853441465582;14674.706505869875;14679.853201467982;764.7094104240408;962.6245764151986;967.9467629280405;989.6437282578266;991.2763682511735;959.0840747086515;967.5307475874196;968.6367612145445;978.9853152202687;983.2871168402886;851.3955091884769;934.644765090618;990.7126933189367;1025.5641352425228;1028.1774580335739;988.4168340678998;1001.8747656542932;1009.6062535611118;1010.2019404670301;1013.8986101389876;634.5526403885295;758.2266088589663;767.8387538616897;769.9153093159748;772.0966469231013;15256.38974441021;15324.540263792103;15606.219689015505;15642.765358519631;15669.843301566953;10648.733781655443;10881.401522916236;13490.325483725774;13723.519676811264;13897.652558686013;10117.443540605263;10340.017698318648;10379.221558383077;10592.894071059267;10652.680419587425;2727.972720272812;3595.6044835068124;3596.0829988353066;3638.308721342936;3643.744937854351;85672.28655426919;86813.56593217056;87774;88095;92058;9806.362586431858;9816.607335706492;9962.203023758082;10083.344582602107;10223.795524089477;18684.34604788826;23551.175708850107;23744.7625523746;23762.287131386085;24197.7580224199;7661.770146895602;7684.077910650758;7698.384129269645;7739.4046229858;7980.68077276914;4051.311277082903;4136.648384887319;4161.646260067868;4231.090315582164;4295.205387003414;3575.1598374382;3671.7980511072146;3673.246984368198;3709.573399059089;3763.7553559018575;674.8515326628134;684.2507454337492;703.8345988692653;704.6054209642616;707.3881092854643;549.1022178737712;558.2770312445393;559.9277383809958;570.0224115641612;599.050504949651;8022.358211343078;8059.355251579859;8070.798230044178;8129.552874591955;8477.915220847712;519.5038738005196;565.7425871228581;579.6637949988997;585.7978997245943;601.7833579911229;3160.2731371784157;3789.147441825567;3862.1503269280715;3900.1614652849207;4024.094578719823;100880.49559752301;100975;101173;101324;102306;86203;86460;87224.5638771802;87315.25369492575;88929.55535222283;44806.32790508145;76661;76696;77081.99999999888;77759.22240777632;7077.363037326665;7530.548167109991;7792.337651299703;7808.180141085331;8014.599270036359;39359.80320098381;40783.796081019405;53137.7343113282;54600.180997284275;55354.72322638361;69611.30388696048;75922;76325.23674763182;76585.23414765781;77032;7951.761447156595;8133.959330203311;9707.70876873695;9792.608295668093;10156.339837910513;8755.693550725695;10568.841467377842;10604.363738175734;10870.456477176267;11139.610113646308;10100.797984040131;10219.693409197736;10254.179665626882;10498.160147188359;10503.05472507478;10094.54574544162;10226.693199204035;10376.844347334947;10535.262531622713;10871.293365931506;9949.403035817873;9960.302778805413;10196.3372380795;10284.537195826355;10459.058684718411;8231;8536;8641.049484556568;8692.565371731514;8762.561871906506;8276.958615207126;8440.493570385797;8458.28104611115;8593.52735599548;8613.556381907734 19:37:48 INFO - PROCESS | 1659 | __end_tp_report 19:37:48 INFO - PROCESS | 1659 | __start_cc_report 19:37:48 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,364 19:37:48 INFO - PROCESS | 1659 | __end_cc_report 19:37:48 INFO - PROCESS | 1659 | __startTimestamp1461033468665__endTimestamp 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | ------- Summary: start ------- 19:37:48 INFO - PROCESS | 1659 | Number of tests: 6 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5874.32 Median:6110.10 stddev:690.68 (11.3%) stddev-sans-first:668.35 19:37:48 INFO - PROCESS | 1659 | Values: 3552.5 3564.3 3591.7 3622.5 3645.0 5937.1 5941.8 5970.4 5977.6 5991.9 5932.4 6006.2 6009.3 6009.5 6024.8 5295.4 5336.0 5435.0 5478.5 5516.1 5278.2 5369.5 5372.4 5400.4 5405.3 5424.9 5432.6 5469.4 5469.8 5476.2 5404.4 5417.5 5435.4 5449.7 5451.5 5165.7 5186.6 5300.6 5371.1 5429.4 4851.9 5763.8 5893.3 5911.4 5927.6 5971.8 6368.0 6389.8 6398.1 6402.8 6045.6 6457.8 6462.9 6478.4 6516.1 4907.4 5802.9 6092.8 6113.6 6122.6 5485.3 6419.6 6478.9 6582.9 6584.3 6234.4 6266.7 6284.7 6290.8 6301.7 6397.2 6402.0 6433.4 6446.1 6450.8 5384.8 6148.0 6290.0 6292.3 6310.0 5017.3 6292.7 6321.7 6361.5 6366.3 4777.5 5058.6 5083.1 5116.6 5125.7 3463.7 4449.7 4572.2 4612.9 4624.3 5911.3 5975.7 6072.5 6082.5 6091.1 6434.0 6448.5 6457.8 6463.4 6481.7 5938.5 5982.3 6074.8 6079.2 6125.6 4684.4 5533.7 5577.9 5582.4 5587.2 6502.9 6619.2 6639.7 6657.3 6689.6 6268.7 6368.4 6404.7 6417.8 6496.4 6673.0 6692.3 6694.2 6717.2 6724.9 6230.8 6392.2 6398.1 6416.7 6426.2 4683.8 6091.8 6329.2 6363.4 6381.1 6225.6 6232.8 6254.4 6264.7 6310.1 6132.9 6208.9 6285.2 6298.4 6302.0 5412.7 5513.9 6118.6 6232.6 6246.2 5228.3 6260.5 6264.4 6270.2 6280.7 6110.1 6127.3 6170.0 6240.2 6253.7 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:63287.72 Median:40201.50 stddev:129588.26 (322.3%) stddev-sans-first:129865.92 19:37:48 INFO - PROCESS | 1659 | Values: 454.5 584.3 616.2 676.0 677.9 31873.0 39937.0 40004.4 40115.4 40287.6 41628.0 41794.8 42431.6 42480.6 42502.0 9598.0 9789.8 9796.8 9836.8 9874.1 9686.1 9793.4 9845.1 9916.2 9963.1 8719.8 9603.2 9871.8 9872.4 9956.5 9811.6 9877.9 9891.7 9914.8 9920.2 9719.0 9814.5 9826.0 9874.1 9876.7 34075.0 37035.1 40787.0 40993.0 41226.6 3144.4 3275.9 3350.2 3419.8 3688.4 23033.2 28139.0 28251.0 28694.0 29031.7 2604.1 2808.6 2810.4 2813.9 2836.3 345548.0 371067.0 372408.1 373494.0 445967.0 47937.8 48534.8 49191.8 67434.7 68082.0 47664.8 47864.6 47903.8 48204.3 48377.8 16557.3 17277.8 17278.5 17452.3 17499.7 12309.9 13275.6 13753.6 13863.4 13980.0 15616.4 15705.3 15754.9 15791.8 15799.3 6595.9 6706.2 6712.7 6726.4 6754.3 788.7 1003.0 1053.3 1068.1 1166.0 30279.2 30405.8 30460.8 30691.2 30843.4 1102.8 1116.2 1146.9 1156.7 1160.9 15561.6 15609.5 15663.6 15670.7 15875.2 532853.0 541594.0 542632.0 545688.0 547841.0 60322.7 61117.7 61722.1 62096.7 62310.0 1504.1 1506.6 1516.1 1528.4 1537.6 29969.4 30760.9 31502.7 32031.5 32812.0 56599.2 56729.4 56905.6 57401.4 57482.9 518488.0 519754.0 522114.0 523307.0 524300.0 44082.1 44831.9 46194.8 46429.3 47018.5 47769.3 48020.0 48567.3 49145.0 49891.3 39388.8 39589.0 40402.0 40428.4 40888.2 38002.0 38203.8 38483.8 38746.0 39114.6 38530.0 39012.0 39438.8 40040.4 40057.4 31245.2 33287.3 33440.0 33445.3 33531.5 21158.3 24922.8 25727.2 33517.7 33666.7 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:35940.74 Median:21588.18 stddev:107923.92 (499.9%) stddev-sans-first:108193.60 19:37:48 INFO - PROCESS | 1659 | Values: 359.5 365.2 370.9 374.1 381.5 20643.0 21871.9 22018.4 22254.7 22749.7 20431.6 20501.1 20741.1 21184.9 21304.5 5874.7 6051.7 6075.6 6093.8 6097.1 4075.7 5693.9 5838.0 5955.6 6092.4 5217.2 6051.2 6076.3 6081.7 6093.6 5854.9 6615.6 6621.6 6643.9 6650.1 5662.5 5824.8 5833.4 5850.2 5870.2 10722.8 13649.2 13968.8 13974.2 14024.9 2127.7 2288.7 2299.6 2532.9 2565.3 9810.8 9946.6 9960.0 10334.2 10593.5 1732.1 1748.9 1779.9 1798.6 1805.8 105946.5 113686.4 116894.0 116981.0 118862.0 11330.1 11597.5 11608.0 11675.1 11682.5 12013.7 14154.6 14321.4 14330.5 14350.0 7554.3 8780.7 8937.5 9091.9 9094.8 9348.6 9362.6 9364.4 9365.7 9454.1 3729.3 4358.4 4533.1 4592.5 4603.5 1787.4 1841.9 1891.5 1940.6 1943.7 726.4 886.0 930.6 987.2 1029.9 16378.9 20404.9 20662.5 21143.5 21178.9 997.8 1002.0 1003.1 1017.7 1020.6 10782.3 10999.1 11290.9 11362.7 11396.0 639049.0 644147.0 651195.0 658366.0 660110.0 90210.7 108197.9 121167.4 133007.0 138996.6 1029.5 1055.5 1060.2 1063.4 1079.9 16139.5 17436.4 18366.5 18462.5 19140.2 52399.0 54333.7 54885.0 57626.7 57755.7 57380.7 72503.6 84331.2 84582.0 86889.6 7216.7 7907.9 8040.4 8324.8 8462.2 11120.6 12950.4 13850.9 13903.4 14286.2 9059.9 10764.4 10992.0 12062.6 12085.8 11817.6 11922.9 11930.9 11965.5 11974.2 12054.3 12128.3 12134.9 12300.8 12366.1 7974.2 8123.8 8214.8 8227.6 8645.4 8722.7 11672.4 11921.2 11948.0 12069.2 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:6154.59 Median:535.35 stddev:3244.19 (606.0%) stddev-sans-first:3235.16 19:37:48 INFO - PROCESS | 1659 | Values: 1591.3 1591.8 1888.7 1982.3 1984.0 6746.6 8831.8 8845.2 9059.4 9076.8 8852.3 8877.3 8990.2 9000.3 9027.1 2505.0 2508.3 2509.1 2520.5 2526.3 2494.6 2551.7 2554.7 2559.7 2567.2 2538.1 2544.6 2566.1 2568.1 2578.0 2526.7 2545.2 2557.3 2559.3 2569.1 2519.5 2527.0 2536.6 2542.8 2566.9 9084.1 9092.9 9153.3 9154.5 9155.7 5536.9 5621.6 5670.5 5683.9 5708.6 3619.2 3674.6 3697.7 3746.5 3754.0 1052.0 1068.0 1080.4 1086.9 1088.0 12178.2 12244.3 12336.9 12350.9 12368.8 4456.5 4478.4 4983.7 5054.8 5060.5 10163.0 10204.6 10370.0 10416.1 10438.3 5589.6 5615.2 5621.0 5626.9 5665.1 4524.4 4994.2 5057.0 5070.0 5086.6 4069.8 4114.3 4119.4 4129.6 4137.0 1212.5 1297.6 1352.1 1360.4 1367.4 1389.1 1403.6 1409.7 1444.1 1446.4 7111.4 8213.0 8295.7 8430.1 8458.0 443.9 450.9 531.7 534.9 535.8 5310.9 6232.6 6268.7 6270.5 6328.4 10492.5 11054.9 11093.8 11131.3 11177.6 8759.6 10793.6 10922.1 10929.0 10933.8 8431.2 8434.9 8475.0 8544.7 8550.8 8108.6 8218.2 8259.2 8293.5 8366.7 9581.7 9740.3 9805.9 9833.2 9857.4 8130.5 8785.2 9677.6 10045.6 10337.5 6983.9 7380.3 7632.2 7735.0 7845.6 7740.1 8384.9 8416.3 8452.2 8458.4 6875.6 7412.4 7519.1 7626.4 7629.0 7288.0 7307.8 7381.8 7392.4 7409.0 7988.8 8003.3 8006.3 8023.6 8054.6 7122.6 7227.8 7265.9 7269.2 7286.8 7250.5 7333.2 7339.4 7381.1 7395.4 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5950.58 Median:6782.15 stddev:1938.88 (28.6%) stddev-sans-first:1897.25 19:37:48 INFO - PROCESS | 1659 | Values: 293.0 341.4 342.2 343.6 349.1 5920.8 6484.6 6837.9 6876.5 6890.9 6820.6 6829.7 6845.8 6852.9 6895.0 4765.3 4900.3 4955.6 4970.9 5049.0 4997.3 5004.3 5026.1 5060.0 5074.7 4990.1 4998.4 5000.5 5005.1 5021.3 4277.9 4981.7 5005.9 5010.0 5030.6 4144.4 4317.5 4327.2 4330.3 4333.9 6320.6 6613.7 6642.0 6677.1 6692.4 4516.8 5198.2 5833.9 5850.3 5885.5 6695.0 7309.5 7313.6 7314.6 7344.2 4667.6 4675.2 4686.1 4689.1 4695.7 7308.1 7638.1 7676.7 7720.7 7731.7 4530.8 4638.5 4745.4 4773.1 4786.9 4849.2 4859.9 4870.6 4876.0 4908.6 5786.4 5844.9 5858.2 5866.4 5883.2 7325.3 7337.6 7340.4 7341.9 7370.1 1598.5 1636.3 1643.2 1665.5 1676.8 1052.1 1060.9 1073.6 1079.3 1079.9 6677.2 6952.8 6959.3 6978.8 7000.3 7573.9 7582.7 7586.5 7604.2 7613.3 6752.3 6778.8 6814.8 6817.6 6818.1 3208.8 3671.5 3989.6 4012.6 4024.1 7802.2 7878.4 7939.6 7988.3 8000.6 6489.2 7750.8 7882.8 7899.4 7916.6 7932.2 7934.9 7962.5 8004.4 8179.8 7333.8 7558.1 7624.4 7662.8 7749.8 5963.4 7440.0 7469.3 7514.8 7528.6 6792.7 7739.0 8052.6 8092.3 8100.1 4720.0 4772.2 4778.8 4793.2 4807.8 7368.4 7539.1 7630.3 7635.4 7668.6 7294.2 7299.8 7304.9 7411.8 7439.3 5801.7 7413.8 7424.3 7430.4 7433.9 5879.7 6494.9 6785.5 7221.1 7243.4 7131.3 7456.4 7470.3 7470.5 7489.0 7189.0 7270.8 7282.1 7289.9 7304.2 19:37:48 INFO - PROCESS | 1659 | 19:37:48 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:19043.99 Median:562.84 stddev:28110.18 (4994.4%) stddev-sans-first:28155.33 19:37:48 INFO - PROCESS | 1659 | Values: 709.5 766.1 766.4 773.9 788.9 15148.8 15471.9 15584.2 15599.6 15601.5 14422.2 14631.4 14655.9 14674.7 14679.9 764.7 962.6 967.9 989.6 991.3 959.1 967.5 968.6 979.0 983.3 851.4 934.6 990.7 1025.6 1028.2 988.4 1001.9 1009.6 1010.2 1013.9 634.6 758.2 767.8 769.9 772.1 15256.4 15324.5 15606.2 15642.8 15669.8 10648.7 10881.4 13490.3 13723.5 13897.7 10117.4 10340.0 10379.2 10592.9 10652.7 2728.0 3595.6 3596.1 3638.3 3643.7 85672.3 86813.6 87774.0 88095.0 92058.0 9806.4 9816.6 9962.2 10083.3 10223.8 18684.3 23551.2 23744.8 23762.3 24197.8 7661.8 7684.1 7698.4 7739.4 7980.7 4051.3 4136.6 4161.6 4231.1 4295.2 3575.2 3671.8 3673.2 3709.6 3763.8 674.9 684.3 703.8 704.6 707.4 549.1 558.3 559.9 570.0 599.1 8022.4 8059.4 8070.8 8129.6 8477.9 519.5 565.7 579.7 585.8 601.8 3160.3 3789.1 3862.2 3900.2 4024.1 100880.5 100975.0 101173.0 101324.0 102306.0 86203.0 86460.0 87224.6 87315.3 88929.6 44806.3 76661.0 76696.0 77082.0 77759.2 7077.4 7530.5 7792.3 7808.2 8014.6 39359.8 40783.8 53137.7 54600.2 55354.7 69611.3 75922.0 76325.2 76585.2 77032.0 7951.8 8134.0 9707.7 9792.6 10156.3 8755.7 10568.8 10604.4 10870.5 11139.6 10100.8 10219.7 10254.2 10498.2 10503.1 10094.5 10226.7 10376.8 10535.3 10871.3 9949.4 9960.3 10196.3 10284.5 10459.1 8231.0 8536.0 8641.0 8692.6 8762.6 8277.0 8440.5 8458.3 8593.5 8613.6 19:37:48 INFO - PROCESS | 1659 | -------- Summary: end -------- 19:37:48 INFO - PROCESS | 1659 | 19:37:49 INFO - TEST-INFO | 1659: exit 0 19:37:49 INFO - TEST-OK | dromaeo_css | took 1111494ms 19:37:49 INFO - TEST-START | kraken 19:37:49 INFO - operating with platform_type : mac_ 19:37:49 INFO - Initialising browser for kraken test... 19:37:49 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmplEBd0d/profile http://localhost:49275/getInfo.html) 19:37:51 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 19:37:51 INFO - PROCESS | 1672 | colorDepth:24 19:37:51 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 19:37:51 INFO - PROCESS | 1672 | __metrics 19:37:51 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:37:52 INFO - TEST-INFO | 1672: exit 0 19:37:52 INFO - Browser initialized. 19:37:52 INFO - Running cycle 1/1 for kraken test... 19:37:52 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/tmplEBd0d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:04 INFO - PROCESS | 1675 | RSS: Main: 217726976 19:38:04 INFO - PROCESS | 1675 | 19:38:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 19:38:07 INFO - PROCESS | 1675 | RSS: Main: 229978112 19:38:07 INFO - PROCESS | 1675 | 19:38:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 19:38:10 INFO - PROCESS | 1675 | RSS: Main: 239448064 19:38:10 INFO - PROCESS | 1675 | 19:38:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 19:38:14 INFO - PROCESS | 1675 | RSS: Main: 242827264 19:38:14 INFO - PROCESS | 1675 | 19:38:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 19:38:17 INFO - PROCESS | 1675 | RSS: Main: 244248576 19:38:17 INFO - PROCESS | 1675 | 19:38:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:38:20 INFO - PROCESS | 1675 | RSS: Main: 244428800 19:38:20 INFO - PROCESS | 1675 | 19:38:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 19:38:23 INFO - PROCESS | 1675 | RSS: Main: 244740096 19:38:23 INFO - PROCESS | 1675 | 19:38:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 19:38:27 INFO - PROCESS | 1675 | RSS: Main: 244465664 19:38:27 INFO - PROCESS | 1675 | 19:38:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 19:38:30 INFO - PROCESS | 1675 | RSS: Main: 244527104 19:38:30 INFO - PROCESS | 1675 | 19:38:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:38:32 INFO - PROCESS | 1675 | RSS: Main: 245125120 19:38:32 INFO - PROCESS | 1675 | 19:38:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:38:35 INFO - PROCESS | 1675 | RSS: Main: 244723712 19:38:35 INFO - PROCESS | 1675 | 19:38:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:38:38 INFO - PROCESS | 1675 | RSS: Main: 244854784 19:38:38 INFO - PROCESS | 1675 | 19:38:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:38:41 INFO - PROCESS | 1675 | RSS: Main: 244781056 19:38:41 INFO - PROCESS | 1675 | 19:38:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:38:44 INFO - PROCESS | 1675 | RSS: Main: 245485568 19:38:44 INFO - PROCESS | 1675 | 19:38:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 19:38:46 INFO - PROCESS | 1675 | RSS: Main: 246894592 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | __start_tp_report 19:38:46 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 19:38:46 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 19:38:46 INFO - PROCESS | 1675 | |i|pagename|runs| 19:38:46 INFO - PROCESS | 1675 | |0;ai-astar;116;109;115;116;117;129;114;114;115;115 19:38:46 INFO - PROCESS | 1675 | |1;audio-beat-detection;152;123;140;154;123;138;139;120;159;118 19:38:46 INFO - PROCESS | 1675 | |2;audio-dft;188;194;200;206;197;193;198;197;257;273 19:38:46 INFO - PROCESS | 1675 | |3;audio-fft;64;95;63;132;53;57;82;85;159;84 19:38:46 INFO - PROCESS | 1675 | |4;audio-oscillator;84;80;130;75;74;79;108;88;115;102 19:38:46 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;86;89;85;88;101;135;85;88;86 19:38:46 INFO - PROCESS | 1675 | |6;imaging-darkroom;101;95;94;117;94;94;94;93;93;94 19:38:46 INFO - PROCESS | 1675 | |7;imaging-desaturate;90;95;92;91;93;91;91;94;133;150 19:38:46 INFO - PROCESS | 1675 | |8;json-parse-financial;57;59;60;62;64;84;91;70;58;55 19:38:46 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;65;83;103;69;87;88;98;96;66 19:38:46 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;80;81;83;83;83;83;83;84;86 19:38:46 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;116;121;121;132;143;129;119;117;120;121 19:38:46 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;126;137;132;133;138;134;133;148;135;139 19:38:46 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;66;68;68;67;68;64;67;68;67;66 19:38:46 INFO - PROCESS | 1675 | __end_tp_report 19:38:46 INFO - PROCESS | 1675 | __start_cc_report 19:38:46 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,926 19:38:46 INFO - PROCESS | 1675 | __end_cc_report 19:38:46 INFO - PROCESS | 1675 | __startTimestamp1461033526112__endTimestamp 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | ------- Summary: start ------- 19:38:46 INFO - PROCESS | 1675 | Number of tests: 14 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.50 stddev:5.06 (4.4%) stddev-sans-first:5.36 19:38:46 INFO - PROCESS | 1675 | Values: 116.0 109.0 115.0 116.0 117.0 129.0 114.0 114.0 115.0 115.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:139.50 stddev:15.10 (10.8%) stddev-sans-first:14.95 19:38:46 INFO - PROCESS | 1675 | Values: 152.0 123.0 140.0 154.0 123.0 138.0 139.0 120.0 159.0 118.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:210.30 Median:199.00 stddev:29.45 (14.8%) stddev-sans-first:30.11 19:38:46 INFO - PROCESS | 1675 | Values: 188.0 194.0 200.0 206.0 197.0 193.0 198.0 197.0 257.0 273.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:87.40 Median:73.00 stddev:34.11 (46.7%) stddev-sans-first:35.11 19:38:46 INFO - PROCESS | 1675 | Values: 64.0 95.0 63.0 132.0 53.0 57.0 82.0 85.0 159.0 84.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:77.00 stddev:19.18 (24.9%) stddev-sans-first:20.04 19:38:46 INFO - PROCESS | 1675 | Values: 84.0 80.0 130.0 75.0 74.0 79.0 108.0 88.0 115.0 102.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:87.00 stddev:15.40 (17.7%) stddev-sans-first:16.26 19:38:46 INFO - PROCESS | 1675 | Values: 89.0 86.0 89.0 85.0 88.0 101.0 135.0 85.0 88.0 86.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:94.00 stddev:7.43 (7.9%) stddev-sans-first:7.73 19:38:46 INFO - PROCESS | 1675 | Values: 101.0 95.0 94.0 117.0 94.0 94.0 94.0 93.0 93.0 94.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:91.50 stddev:21.26 (23.2%) stddev-sans-first:22.10 19:38:46 INFO - PROCESS | 1675 | Values: 90.0 95.0 92.0 91.0 93.0 91.0 91.0 94.0 133.0 150.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:63.00 stddev:12.18 (19.3%) stddev-sans-first:12.48 19:38:46 INFO - PROCESS | 1675 | Values: 57.0 59.0 60.0 62.0 64.0 84.0 91.0 70.0 58.0 55.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:82.10 Median:85.00 stddev:14.62 (17.2%) stddev-sans-first:14.30 19:38:46 INFO - PROCESS | 1675 | Values: 66.0 65.0 83.0 103.0 69.0 87.0 88.0 98.0 96.0 66.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.62 (2.0%) stddev-sans-first:1.69 19:38:46 INFO - PROCESS | 1675 | Values: 82.0 80.0 81.0 83.0 83.0 83.0 83.0 83.0 84.0 86.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:121.00 stddev:8.37 (6.9%) stddev-sans-first:8.38 19:38:46 INFO - PROCESS | 1675 | Values: 116.0 121.0 121.0 132.0 143.0 129.0 119.0 117.0 120.0 121.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:136.00 stddev:5.72 (4.2%) stddev-sans-first:4.93 19:38:46 INFO - PROCESS | 1675 | Values: 126.0 137.0 132.0 133.0 138.0 134.0 133.0 148.0 135.0 139.0 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.29 (1.9%) stddev-sans-first:1.32 19:38:46 INFO - PROCESS | 1675 | Values: 66.0 68.0 68.0 67.0 68.0 64.0 67.0 68.0 67.0 66.0 19:38:46 INFO - PROCESS | 1675 | -------- Summary: end -------- 19:38:46 INFO - PROCESS | 1675 | 19:38:46 INFO - TEST-INFO | 1675: exit 0 19:38:47 INFO - TEST-OK | kraken | took 57866ms 19:38:47 INFO - SUITE-END | took 1169s 19:38:47 INFO - Completed test suite (00:19:29) 19:38:47 INFO - javascript benchmark 19:38:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3552.484889690995, 3564.322778672052, 3591.694705949994, 3622.474741162531, 3644.9976256529453, 5937.079752638338, 5941.792037278696, 5970.373110823366, 5977.5815692901515, 5991.910121348173, 5932.406759324065, 6006.159137720711, 6009.338972713009, 6009.519238460924, 6024.819255422344, 5295.391030031538, 5336.0, 5435.021696094701, 5478.534324582415, 5516.062269414209, 5278.155495120782, 5369.543588794957, 5372.355317361922, 5400.405955344909, 5405.324334458192, 5424.945750542503, 5432.619716619838, 5469.425710300421, 5469.808556700516, 5476.17857321401, 5404.378496472897, 5417.51242388183, 5435.374931882845, 5449.700266485342, 5451.454854514556, 5165.74171291434, 5186.636935414523, 5300.628955973083, 5371.113766228606, 5429.375621803503, 4851.902961940777, 5763.769449222026, 5893.322267939199, 5911.379305172938, 5927.614705044159, 5971.8056388722425, 6367.968160159216, 6389.808305750788, 6398.104265402847, 6402.839929001766, 6045.576809623328, 6457.806265812033, 6462.90305645411, 6478.384553467413, 6516.0877477153235, 4907.386576677915, 5802.912956305574, 6092.817215483543, 6113.572049956505, 6122.602030867979, 5485.314335708036, 6419.614823110628, 6478.935210647834, 6582.868342633121, 6584.275729669733, 6234.37656234382, 6266.655333956585, 6284.717187726564, 6290.8427289317215, 6301.747930082837, 6397.200349956255, 6402.0, 6433.388828061326, 6446.129772480749, 6450.838729031718, 5384.784608615611, 6148.0, 6290.025046117859, 6292.307846136921, 6310.0, 5017.347744793154, 6292.716827742763, 6321.683915804283, 6361.522885783585, 6366.299707032223, 4777.546133117348, 5058.595312375001, 5083.135866902636, 5116.56509196715, 5125.692458452505, 3463.7229021678204, 4449.688521803508, 4572.154151481986, 4612.86161415158, 4624.28323609841, 5911.290645122527, 5975.731092100866, 6072.453479186895, 6082.482988945901, 6091.0558863376245, 6433.967830160819, 6448.484121270287, 6457.773977910751, 6463.353664633593, 6481.675916204171, 5938.49522790559, 5982.282126144891, 6074.848128796815, 6079.179310793074, 6125.571210015345, 4684.367610372624, 5533.695646739468, 5577.888442231133, 5582.385937546866, 5587.217789509472, 6502.934970650233, 6619.205695316593, 6639.734410623618, 6657.300983396771, 6689.5986240825705, 6268.717907694256, 6368.395002474757, 6404.743810247538, 6417.839554011187, 6496.350364963466, 6673.032410300382, 6692.330766923464, 6694.230163531061, 6717.227518835396, 6724.865502689821, 6230.7507699691505, 6392.232932048184, 6398.104265402941, 6416.679166041586, 6426.196725409324, 4683.758803916897, 6091.847703807441, 6329.208848893888, 6363.395477429637, 6381.074744162163, 6225.595336303126, 6232.844178895564, 6254.3745625437095, 6264.655443950626, 6310.148130002391, 6132.877342453036, 6208.875822483616, 6285.2457705075685, 6298.433141017331, 6302.0, 5412.675239485643, 5513.897220555985, 6118.649636126507, 6232.5948813328805, 6246.219222597176, 5228.346456692913, 6260.499160067093, 6264.404881536247, 6270.184875966095, 6280.654563999024, 6110.103144028831, 6127.325994140552, 6169.96915015422, 6240.157578726814, 6253.6560489173535], "unit": "score", "name": "dojo.html", "value": 5833.589140745172}, {"lowerIsBetter": false, "replicates": [454.5409136771859, 584.3484514766037, 616.2020183861898, 675.9725217669143, 677.8882632482728, 31873.0, 39937.0, 40004.39993400101, 40115.39826902595, 40287.597124028754, 41628.0, 41794.791026044826, 42431.57568424315, 42480.57519424805, 42502.0, 9597.999999999982, 9789.804203915917, 9796.804063918717, 9836.803263934717, 9874.061964113398, 9686.128248457637, 9793.363431376973, 9845.11393974542, 9916.206703463706, 9963.053509916546, 8719.782005449852, 9603.18372938301, 9871.802563948717, 9872.35829671069, 9956.452395118265, 9811.607535698598, 9877.851832222523, 9891.653792117277, 9914.752131196778, 9920.156786673142, 9718.951405242999, 9814.509274536245, 9825.950870245602, 9874.111329980336, 9876.703698889045, 34075.0, 37035.07412314687, 40787.0, 40993.0, 41226.58773412257, 3144.4497212987635, 3275.918102047444, 3350.2294472271515, 3419.760616756828, 3688.354537955847, 23033.19383821575, 28139.0, 28251.0, 28694.0, 29031.70968290311, 2604.101584953207, 2808.5506318988864, 2810.423863108058, 2813.943721125566, 2836.347640042781, 345548.0, 371067.0, 372408.1379593112, 373494.0, 445966.99999999674, 47937.80155496141, 48534.786630333816, 49191.754041230284, 67434.66282668556, 68081.97877031848, 47664.761676191396, 47864.56406307816, 47903.76048119737, 48204.27693584599, 48377.758111209216, 16557.337706491606, 17277.82722172762, 17278.481645550655, 17452.301907923542, 17499.65000699979, 12309.93845030769, 13275.606061363418, 13753.587392378246, 13863.445462181602, 13980.0, 15616.3753449863, 15705.293261803246, 15754.9212253938, 15791.763123553155, 15799.289031993589, 6595.934040659532, 6706.161729783777, 6712.664366781642, 6726.360995705498, 6754.290799466084, 788.6648174525918, 1002.979940401188, 1053.3153450257394, 1068.1027936533349, 1165.9972423715599, 30279.243018924262, 30405.78376864945, 30460.847695761822, 30691.232719181753, 30843.38313233723, 1102.779444111181, 1116.151724689242, 1146.9139814513944, 1156.7108222944264, 1160.9187356885107, 15561.610959726097, 15609.531714048597, 15663.608409789846, 15670.686586268212, 15875.20623968797, 532853.0, 541594.0, 542632.0, 545688.0, 547841.0, 60322.698386507785, 61117.69441152766, 61722.074168887506, 62096.68951655303, 62310.0, 1504.0674781635455, 1506.6459382045211, 1516.1433789908447, 1528.3733669195576, 1537.5541093082882, 29969.400611988076, 30760.923367682022, 31502.684973149975, 32031.519527207576, 32812.0, 56599.15101273567, 56729.432705672414, 56905.57736056632, 57401.42598573961, 57482.85034299207, 518488.0, 519754.0, 522114.0, 523307.0, 524300.0, 44082.118357633306, 44831.87920302019, 46194.769026156, 46429.3035604473, 47018.529814702786, 47769.28346074881, 48020.0, 48567.27149092837, 49145.0, 49891.25163122629, 39388.803055984536, 39589.0, 40402.0, 40428.393574097, 40888.1822363557, 38002.0, 38203.80898095492, 38483.80758096192, 38746.0, 39114.60885391109, 38530.0, 39012.0, 39438.80280598579, 40040.3993940097, 40057.39913901352, 31245.218869528442, 33287.334253314315, 33440.0, 33445.33109337751, 33531.4970275451, 21158.259460918795, 24922.750772492043, 25727.228183154537, 33517.66482335146, 33666.663333366356], "unit": "score", "name": "ext.html", "value": 20023.02671824939}, {"lowerIsBetter": false, "replicates": [359.5182455509617, 365.2202547560958, 370.944358346248, 374.12641482139196, 381.49832969644933, 20643.0, 21871.890640546815, 22018.44953876152, 22254.666180007294, 22749.658755118686, 20431.591368172627, 20501.07745151468, 20741.06665200066, 21184.89407552964, 21304.4673883153, 5874.70626468677, 6051.6671583063135, 6075.574709770318, 6093.756249750027, 6097.05495648173, 4075.735077219986, 5693.857653558653, 5838.0, 5955.553333499983, 6092.390760923917, 5217.243499692542, 6051.243594550681, 6076.3316035236085, 6081.665508397036, 6093.603915745484, 5854.853628659296, 6615.569987950767, 6621.635810030446, 6643.9003414948575, 6650.1022361980995, 5662.518685911702, 5824.796132135355, 5833.387494313079, 5850.180974663551, 5870.20752198452, 10722.839157412645, 13649.249291288976, 13968.790468142986, 13974.161550306913, 14024.929875350557, 2127.712758777561, 2288.7088049783874, 2299.5745787029286, 2532.898684052654, 2565.268898363976, 9810.803783924353, 9946.602135914554, 9959.950200248952, 10334.224933130045, 10593.523291451904, 1732.1166205235295, 1748.8950662960262, 1779.9377021804175, 1798.640271945603, 1805.783306003288, 105946.47026764817, 113686.43156784163, 116894.0, 116981.0, 118862.0, 11330.09359251258, 11597.478113484913, 11608.0, 11675.124365672438, 11682.532698692126, 12013.699657508458, 14154.64613384653, 14321.427142914376, 14330.49843255481, 14349.995500314877, 7554.2823431773895, 8780.736577902673, 8937.46375217476, 9091.909080909238, 9094.81810363789, 9348.626054957726, 9362.625494980124, 9364.438133712, 9365.672201472917, 9454.101860323259, 3729.310077635646, 4358.433403657567, 4533.116042371772, 4592.494825569252, 4603.516630753789, 1787.374418953382, 1841.9316796258406, 1891.498752830501, 1940.5827747034455, 1943.6987266973642, 726.3970904149543, 885.9911400886037, 930.6040938592112, 987.1855719031828, 1029.8558201851747, 16378.896882493957, 20404.897975510026, 20662.483437914172, 21143.471413214484, 21178.94105294729, 997.8154041502345, 1001.979960400788, 1003.087190656499, 1017.7252141921788, 1020.642775028734, 10782.299150555189, 10999.120070394349, 11290.885346572153, 11362.659120226406, 11396.0, 639049.0, 644147.0, 651195.0, 658366.0, 660110.0, 90210.74473138092, 108197.91802082036, 121167.39416302861, 133007.0, 138996.61003389835, 1029.5161274201114, 1055.4828134214333, 1060.183658582887, 1063.42575009494, 1079.881213066562, 16139.515814525583, 17436.389726359517, 18366.540836479195, 18462.538436538656, 19140.23439062422, 52398.95202096013, 54333.72833135809, 54885.0, 57626.71186644208, 57755.71122144363, 57380.71309643425, 72503.63748181437, 84331.15668843478, 84582.0, 86889.56555217183, 7216.7474138404905, 7907.920920790719, 8040.39697022714, 8324.833503329779, 8462.19609137131, 11120.555177793121, 12950.352482375654, 13850.861491384958, 13903.374348154155, 14286.214258215898, 9059.867516560429, 10764.3541387517, 10992.010719035325, 12062.577809776616, 12085.758284834079, 11817.645470635895, 11922.880771192524, 11930.940345298219, 11965.461554229907, 11974.22167559106, 12054.337011464102, 12128.272303661808, 12134.878651213729, 12300.81548776787, 12366.134370593973, 7974.242446967529, 8123.83752324962, 8214.794630134056, 8227.629756660845, 8645.394822362374, 8722.651093956425, 11672.358020308964, 11921.225120367495, 11948.044156467287, 12069.155159139127], "unit": "score", "name": "jquery.html", "value": 9526.357794374218}, {"lowerIsBetter": false, "replicates": [1591.323687432841, 1591.8408159184082, 1888.6978083506633, 1982.3458258774606, 1983.960320793585, 6746.62893540855, 8831.779205519866, 8845.248153906918, 9059.365844390895, 9076.773080672978, 8852.291816654668, 8877.334199935014, 8990.190882820561, 9000.324975626821, 9027.14242146995, 2504.987475062627, 2508.3227528567277, 2509.0967251789343, 2520.5085008423366, 2526.3305224115625, 2494.625806129077, 2551.7065537463245, 2554.7062087859854, 2559.718430972601, 2567.242663414297, 2538.0862889359814, 2544.643749875019, 2566.101864347482, 2568.126836875462, 2577.9742202578013, 2526.684164479431, 2545.185540627, 2557.3350928758473, 2559.296193546771, 2569.0622922633197, 2519.5212909547313, 2526.9620955685496, 2536.6321883326814, 2542.7711505964553, 2566.8716564171905, 9084.09159084093, 9092.8636070459, 9153.267738580898, 9154.542272886396, 9155.725328240163, 5536.916946245809, 5621.550275977912, 5670.518005969498, 5683.914741278884, 5708.600397972144, 3619.2037751694584, 3674.595794462607, 3697.7411581189326, 3746.4754934309217, 3754.0239537720117, 1051.9737006574896, 1067.9946600267026, 1080.4111759091313, 1086.9456527173609, 1087.9782404351947, 12178.208416452902, 12244.326562039085, 12336.938315308456, 12350.876491235153, 12368.752624947541, 4456.487503937024, 4478.39541661878, 4983.651144419929, 5054.82308119214, 5060.544550990355, 10163.034511721375, 10204.591816327264, 10370.0, 10416.114630256361, 10438.269321147598, 5589.636673616284, 5615.185798059259, 5621.0444224481935, 5626.943730562723, 5665.12190610456, 4524.411826462539, 4994.150994330972, 5057.0, 5069.9746501267255, 5086.643934924594, 4069.8251394319373, 4114.259433301974, 4119.382092686061, 4129.648979836687, 4136.96575856036, 1212.5452955141823, 1297.5588299978053, 1352.0670737191306, 1360.415021540747, 1367.3591689972072, 1389.062382891544, 1403.6280385697798, 1409.6828213652052, 1444.0830072903782, 1446.3636000159895, 7111.395531379787, 8213.0, 8295.709650162215, 8430.072692003874, 8457.957710211409, 443.8912466445677, 450.92559727645227, 531.7288183026684, 534.9144136938071, 535.7883635963773, 5310.893782124336, 6232.56372053961, 6268.686565671698, 6270.467010304084, 6328.430441260217, 10492.475376231157, 11054.889451105386, 11093.83359249612, 11131.276467029616, 11177.608783692533, 8759.60581773809, 10793.568257269779, 10922.071623912056, 10929.0, 10933.835992460119, 8431.241188293083, 8434.915650843413, 8474.957625211835, 8544.743657690155, 8550.828983420297, 8108.594570271581, 8218.178182181973, 8259.21537453941, 8293.460925039853, 8366.665333386596, 9581.712548623553, 9740.318177727491, 9805.901940980784, 9833.16418104469, 9857.408555486694, 8130.512169269863, 8785.165409286108, 9677.645129681709, 10045.598176072876, 10337.483125843528, 6983.860322793617, 7380.298871607189, 7632.236776322324, 7734.961325193338, 7845.5684937329, 7740.109887363025, 8384.874226886479, 8416.3266938646, 8452.197041281068, 8458.40791144614, 6875.5530890491955, 7412.369948554433, 7519.097708275042, 7626.351760100453, 7629.046369203849, 7287.963560182166, 7307.7807665770115, 7381.8154546136775, 7392.4086073115095, 7408.9629551851895, 7988.8002799928145, 8003.319717823817, 8006.279434850891, 8023.598820058857, 8054.5569993650915, 7122.60825654594, 7227.819304517429, 7265.9273407265255, 7269.1640461345505, 7286.781396558112, 7250.528715633467, 7333.193348731528, 7339.412846972123, 7381.077365329334, 7395.445341599294], "unit": "score", "name": "mootools.html", "value": 4952.207205841319}, {"lowerIsBetter": false, "replicates": [292.9619149510563, 341.411065911303, 342.23851929456947, 343.6048544174199, 349.09061893766744, 5920.81583683264, 6484.578502397341, 6837.863242735149, 6876.484263680225, 6890.931905554641, 6820.567680787029, 6829.692663830139, 6845.828854278646, 6852.897206541893, 6895.034695142672, 4765.261384485393, 4900.264960255972, 4955.6035517158725, 4970.900581988358, 5049.040682270375, 4997.275395067732, 5004.349434573501, 5026.095302845504, 5059.974700126494, 5074.695518268897, 4990.076835785373, 4998.375203099613, 5000.499950005007, 5005.0990821652085, 5021.322121513604, 4277.930517370657, 4981.72600506972, 5005.874853128665, 5010.023045506127, 5030.57240134589, 4144.4197812306, 4317.525072242082, 4327.199468098412, 4330.2638551446325, 4333.8699839004885, 6320.62076275425, 6613.735450581971, 6642.036904648847, 6677.065210870482, 6692.397684208396, 4516.841910533149, 5198.246254293144, 5833.941660583425, 5850.327212370589, 5885.470307672287, 6695.0, 7309.451791115687, 7313.597752123631, 7314.5611263323835, 7344.192138864721, 4667.6265898728025, 4675.228587283094, 4686.133065382915, 4689.062187562501, 4695.67130300879, 7308.086489188904, 7638.121616014174, 7676.7313144040245, 7720.691172353156, 7731.690732370755, 4530.773461326987, 4638.536146385402, 4745.3593764842, 4773.069251495925, 4786.856394308176, 4849.248366503198, 4859.854204373874, 4870.6103511718975, 4875.975620121877, 4908.582770464479, 5786.421357864264, 5844.9415505845245, 5858.238429004202, 5866.413358664185, 5883.17635531026, 7325.267473252632, 7337.559746415232, 7340.37606803417, 7341.926580734124, 7370.078740157481, 1598.5444148417646, 1636.3291050669168, 1643.2030465224357, 1665.5170000699661, 1676.773635559184, 1052.0899422000068, 1060.931039482431, 1073.608133031438, 1079.3254216114929, 1079.8920107989138, 6677.23211830636, 6952.791416257521, 6959.338862808025, 6978.825529361807, 7000.26497217795, 7573.9242607573215, 7582.658780354897, 7586.468947173756, 7604.2395760423515, 7613.276738709814, 6752.291009444036, 6778.76274330406, 6814.8296292592095, 6817.5568588041615, 6818.113645226089, 3208.775385722977, 3671.4676371926457, 3989.6209860063245, 4012.578679238696, 4024.054347228399, 7802.180771019075, 7878.448508604457, 7939.603019848984, 7988.320992715568, 8000.599970001476, 6489.156409666807, 7750.7674769756995, 7882.842343153105, 7899.407544434191, 7916.643751031217, 7932.246436588515, 7934.920650793418, 7962.482438641469, 8004.359651227888, 8179.754607361789, 7333.779986600411, 7558.093028836574, 7624.390048796194, 7662.846743064996, 7749.7675069748, 5963.4334738199805, 7440.0, 7469.290417410337, 7514.849703006019, 7528.585927773806, 6792.675428291634, 7738.993930788962, 8052.5571093590415, 8092.271695547429, 8100.0684921234815, 4719.9852031813325, 4772.164871147465, 4778.761061946958, 4793.23308270675, 4807.846116931842, 7368.447366447431, 7539.095308563007, 7630.313271805564, 7635.350995165473, 7668.57822819728, 7294.234105418855, 7299.817504562428, 7304.904264360389, 7411.8147046324275, 7439.256074392518, 5801.6519008859605, 7413.777586672409, 7424.331810137113, 7430.405567554474, 7433.851322973402, 5879.7060146993335, 6494.935050649622, 6785.541108661661, 7221.097362829646, 7243.420526357984, 7131.25121862197, 7456.366208872307, 7470.252974702486, 7470.4770666052855, 7488.9625551871895, 7188.9640551799, 7270.781876543712, 7282.12614486265, 7289.927100728924, 7304.233055529306], "unit": "score", "name": "prototype.html", "value": 5297.838372568362}, {"lowerIsBetter": false, "replicates": [709.4678990756933, 766.1227894061303, 766.3983772738402, 773.9458237923346, 788.9053313602369, 15148.77276840847, 15471.92264038681, 15584.220788960549, 15599.610009749762, 15601.531954041397, 14422.206778627198, 14631.41474341025, 14655.853441465582, 14674.706505869875, 14679.853201467982, 764.7094104240408, 962.6245764151986, 967.9467629280405, 989.6437282578266, 991.2763682511735, 959.0840747086515, 967.5307475874196, 968.6367612145445, 978.9853152202687, 983.2871168402886, 851.3955091884769, 934.644765090618, 990.7126933189367, 1025.5641352425228, 1028.1774580335739, 988.4168340678998, 1001.8747656542932, 1009.6062535611118, 1010.2019404670301, 1013.8986101389876, 634.5526403885295, 758.2266088589663, 767.8387538616897, 769.9153093159748, 772.0966469231013, 15256.38974441021, 15324.540263792103, 15606.219689015505, 15642.765358519631, 15669.843301566953, 10648.733781655443, 10881.401522916236, 13490.325483725774, 13723.519676811264, 13897.652558686013, 10117.443540605263, 10340.017698318648, 10379.221558383077, 10592.894071059267, 10652.680419587425, 2727.972720272812, 3595.6044835068124, 3596.0829988353066, 3638.308721342936, 3643.744937854351, 85672.28655426919, 86813.56593217056, 87774.0, 88095.0, 92058.0, 9806.362586431858, 9816.607335706492, 9962.203023758082, 10083.344582602107, 10223.795524089477, 18684.34604788826, 23551.175708850107, 23744.7625523746, 23762.287131386085, 24197.7580224199, 7661.770146895602, 7684.077910650758, 7698.384129269645, 7739.4046229858, 7980.68077276914, 4051.311277082903, 4136.648384887319, 4161.646260067868, 4231.090315582164, 4295.205387003414, 3575.1598374382, 3671.7980511072146, 3673.246984368198, 3709.573399059089, 3763.7553559018575, 674.8515326628134, 684.2507454337492, 703.8345988692653, 704.6054209642616, 707.3881092854643, 549.1022178737712, 558.2770312445393, 559.9277383809958, 570.0224115641612, 599.050504949651, 8022.358211343078, 8059.355251579859, 8070.798230044178, 8129.552874591955, 8477.915220847712, 519.5038738005196, 565.7425871228581, 579.6637949988997, 585.7978997245943, 601.7833579911229, 3160.2731371784157, 3789.147441825567, 3862.1503269280715, 3900.1614652849207, 4024.094578719823, 100880.49559752301, 100975.0, 101173.0, 101324.0, 102306.0, 86203.0, 86460.0, 87224.5638771802, 87315.25369492575, 88929.55535222283, 44806.32790508145, 76661.0, 76696.0, 77081.99999999888, 77759.22240777632, 7077.363037326665, 7530.548167109991, 7792.337651299703, 7808.180141085331, 8014.599270036359, 39359.80320098381, 40783.796081019405, 53137.7343113282, 54600.180997284275, 55354.72322638361, 69611.30388696048, 75922.0, 76325.23674763182, 76585.23414765781, 77032.0, 7951.761447156595, 8133.959330203311, 9707.70876873695, 9792.608295668093, 10156.339837910513, 8755.693550725695, 10568.841467377842, 10604.363738175734, 10870.456477176267, 11139.610113646308, 10100.797984040131, 10219.693409197736, 10254.179665626882, 10498.160147188359, 10503.05472507478, 10094.54574544162, 10226.693199204035, 10376.844347334947, 10535.262531622713, 10871.293365931506, 9949.403035817873, 9960.302778805413, 10196.3372380795, 10284.537195826355, 10459.058684718411, 8231.0, 8536.0, 8641.049484556568, 8692.565371731514, 8762.561871906506, 8276.958615207126, 8440.493570385797, 8458.28104611115, 8593.52735599548, 8613.556381907734], "unit": "score", "name": "yui.html", "value": 6914.38421844372}], "name": "dromaeo_css", "value": 7659.132390765611}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 115.0, 116.0, 117.0, 129.0, 114.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 140.0, 154.0, 123.0, 138.0, 139.0, 120.0, 159.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 136.6}, {"lowerIsBetter": true, "replicates": [188.0, 194.0, 200.0, 206.0, 197.0, 193.0, 198.0, 197.0, 257.0, 273.0], "unit": "score", "name": "audio-dft", "value": 210.3}, {"lowerIsBetter": true, "replicates": [64.0, 95.0, 63.0, 132.0, 53.0, 57.0, 82.0, 85.0, 159.0, 84.0], "unit": "score", "name": "audio-fft", "value": 87.4}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 130.0, 75.0, 74.0, 79.0, 108.0, 88.0, 115.0, 102.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 101.0, 135.0, 85.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.2}, {"lowerIsBetter": true, "replicates": [101.0, 95.0, 94.0, 117.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 96.9}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 92.0, 91.0, 93.0, 91.0, 91.0, 94.0, 133.0, 150.0], "unit": "score", "name": "imaging-desaturate", "value": 102.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 60.0, 62.0, 64.0, 84.0, 91.0, 70.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 66.0}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 83.0, 103.0, 69.0, 87.0, 88.0, 98.0, 96.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.1}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 81.0, 83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 121.0, 132.0, 143.0, 129.0, 119.0, 117.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [126.0, 137.0, 132.0, 133.0, 138.0, 134.0, 133.0, 148.0, 135.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 67.0, 68.0, 64.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1493.1000000000001}]} 19:38:47 INFO - Return code: 0 19:38:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:38:47 ERROR - # TBPL SUCCESS # 19:38:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:38:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:38:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:38:47 INFO - 2016-04-18 19:38:47.419 screenresolution[1680:10757] starting screenresolution argv=screenresolution get 19:38:47 INFO - 2016-04-18 19:38:47.422 screenresolution[1680:10757] Display 0: 1600x1200x32@60 19:38:47 INFO - 2016-04-18 19:38:47.428 screenresolution[1681:10760] starting screenresolution argv=screenresolution list 19:38:47 INFO - Available Modes on Display 0 19:38:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:38:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:38:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:38:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:38:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:38:47 INFO - Intel Iris: 19:38:47 INFO - Chipset Model: Intel Iris 19:38:47 INFO - Type: GPU 19:38:47 INFO - Bus: Built-In 19:38:47 INFO - VRAM (Dynamic, Max): 1536 MB 19:38:47 INFO - Vendor: Intel (0x8086) 19:38:47 INFO - Device ID: 0x0a2e 19:38:47 INFO - Revision ID: 0x0009 19:38:47 INFO - Displays: 19:38:47 INFO - Display: 19:38:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:38:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:38:47 INFO - Display Serial Number: 1600x1200 60 19:38:47 INFO - Main Display: Yes 19:38:47 INFO - Mirror: Off 19:38:47 INFO - Online: Yes 19:38:47 INFO - Rotation: Supported 19:38:47 INFO - Return code: 0 19:38:47 INFO - Running post-action listener: _resource_record_post_action 19:38:47 INFO - Running post-run listener: _resource_record_post_run 19:38:48 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37635584; Write bytes: 666388992; Read time: 392; Write time: 3274 19:38:48 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 352035328; Write bytes: 353155072; Read time: 27045; Write time: 645 19:38:48 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 36713984; Write bytes: 302641664; Read time: 378; Write time: 2594 19:38:48 INFO - Running post-run listener: _upload_blobber_files 19:38:48 INFO - Blob upload gear active. 19:38:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:38:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:38:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:49 INFO - (blobuploader) - INFO - Done attempting. 19:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:51 INFO - (blobuploader) - INFO - Done attempting. 19:38:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:51 INFO - Return code: 0 19:38:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4621c04a95ccbe91338ec9410c0cb5486bbadd1ff1a83d134b1dcc36e344f374b6658d8a4fce20bf46b8c151fb020c08037ba712c19c1c5de71dd69edd326fdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a52e2066672b689bf5b06f22258ae9d835aaf88845662ddbba4278aecf08bb3830abbff345a371a794530932dbee518192013e2bc0cacb549c091ad0606ea79"} 19:38:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:51 INFO - Contents: 19:38:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4621c04a95ccbe91338ec9410c0cb5486bbadd1ff1a83d134b1dcc36e344f374b6658d8a4fce20bf46b8c151fb020c08037ba712c19c1c5de71dd69edd326fdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a52e2066672b689bf5b06f22258ae9d835aaf88845662ddbba4278aecf08bb3830abbff345a371a794530932dbee518192013e2bc0cacb549c091ad0606ea79"} 19:38:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:51 INFO - Copying logs to upload dir... 19:38:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.231262 ========= master_lag: 1.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-18 19:38:52.541790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 19:38:52.543594) ========= 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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4621c04a95ccbe91338ec9410c0cb5486bbadd1ff1a83d134b1dcc36e344f374b6658d8a4fce20bf46b8c151fb020c08037ba712c19c1c5de71dd69edd326fdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a52e2066672b689bf5b06f22258ae9d835aaf88845662ddbba4278aecf08bb3830abbff345a371a794530932dbee518192013e2bc0cacb549c091ad0606ea79"} build_url:https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/XQXelgaoQbackMOKU4aBAw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4621c04a95ccbe91338ec9410c0cb5486bbadd1ff1a83d134b1dcc36e344f374b6658d8a4fce20bf46b8c151fb020c08037ba712c19c1c5de71dd69edd326fdb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a52e2066672b689bf5b06f22258ae9d835aaf88845662ddbba4278aecf08bb3830abbff345a371a794530932dbee518192013e2bc0cacb549c091ad0606ea79"}' ========= master_lag: 0.41 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 19:38:52.966733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-18 19:38:52.967101) ========= 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.0BmC3DIHs1/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.l5Kh22kh1y/Listeners TMPDIR=/var/folders/kk/yyt80n5134xftnxh1jqzdjsw00000w/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.005155 ========= master_lag: 6.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-18 19:38:59.124672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 19:38:59.124955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 19:38:59.643690) ========= ========= Total master_lag: 14.56 =========