builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0338 starttime: 1493922184.11 results: success (0) buildid: 20170504095619 builduid: f63e2a2a030245a595809f5819453b9a revision: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.115194) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.115654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.115952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.141926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.142278) ========= 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.IDcdiw8LYd/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.D7re1flfhe/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 --2017-05-04 11:23:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.08M=0.001s 2017-05-04 11:23:04 (8.08 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.253266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.253586) ========= 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.IDcdiw8LYd/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.D7re1flfhe/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.020788 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:04.304636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 11:23:04.305443) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d92d578f631e730dd9c1f1725d2ee81ccb3ed8de --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d92d578f631e730dd9c1f1725d2ee81ccb3ed8de --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IDcdiw8LYd/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.D7re1flfhe/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 2017-05-04 11:23:04,406 truncating revision to first 12 chars 2017-05-04 11:23:04,406 Setting DEBUG logging. 2017-05-04 11:23:04,406 attempt 1/10 2017-05-04 11:23:04,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d92d578f631e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 11:23:06,006 unpacking tar archive at: mozilla-beta-d92d578f631e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.866678 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 11:23:06.198005) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:06.198329) ========= script_repo_revision: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:06.198728) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:06.199021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 11:23:06.219600) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-05-04 11:23:06.220026) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IDcdiw8LYd/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.D7re1flfhe/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:23:06 INFO - MultiFileLogger online at 20170504 11:23:06 in /builds/slave/test 11:23:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:23:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:06 INFO - {'append_to_log': False, 11:23:06 INFO - 'base_work_dir': '/builds/slave/test', 11:23:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:23:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:06 INFO - 'branch': 'Mozilla-Beta', 11:23:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:06 INFO - 'config_files': ('talos/mac_config.py',), 11:23:06 INFO - 'default_actions': ('clobber', 11:23:06 INFO - 'read-buildbot-config', 11:23:06 INFO - 'download-and-extract', 11:23:06 INFO - 'populate-webroot', 11:23:06 INFO - 'create-virtualenv', 11:23:06 INFO - 'install', 11:23:06 INFO - 'run-tests'), 11:23:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:06 INFO - 'download_minidump_stackwalk': True, 11:23:06 INFO - 'download_symbols': 'ondemand', 11:23:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:06 INFO - 'gecko_profile': False, 11:23:06 INFO - 'gecko_profile_interval': 0, 11:23:06 INFO - 'installer_path': 'installer.exe', 11:23:06 INFO - 'log_level': 'info', 11:23:06 INFO - 'log_name': 'talos', 11:23:06 INFO - 'log_to_console': True, 11:23:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:23:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:23:06 INFO - 'opt_config_files': (), 11:23:06 INFO - 'pip_index': False, 11:23:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:06 INFO - 'cmd': ('bash', 11:23:06 INFO - '-c', 11:23:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:06 INFO - 'enabled': True, 11:23:06 INFO - 'halt_on_failure': False, 11:23:06 INFO - 'name': 'check_screen_resolution'},), 11:23:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:23:06 INFO - 'cmd': ('bash', 11:23:06 INFO - '-c', 11:23:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:23:06 INFO - 'enabled': True, 11:23:06 INFO - 'halt_on_failure': False, 11:23:06 INFO - 'name': 'check_screen_resolution'},), 11:23:06 INFO - 'run_cmd_checks_enabled': True, 11:23:06 INFO - 'suite': 'dromaeojs-e10s', 11:23:06 INFO - 'system_bits': '32', 11:23:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:06 INFO - 'title': 't-yosemite-r7-0338', 11:23:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:06 INFO - 'use_talos_json': True, 11:23:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:06 INFO - 'work_dir': 'build'} 11:23:06 INFO - [mozharness: 2017-05-04 18:23:06.439548Z] Running clobber step. 11:23:06 INFO - Running pre-action listener: _resource_record_pre_action 11:23:06 INFO - Running main action method: clobber 11:23:06 INFO - rmtree: /builds/slave/test/build 11:23:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:08 INFO - Running post-action listener: _resource_record_post_action 11:23:08 INFO - [mozharness: 2017-05-04 18:23:08.458877Z] Finished clobber step (success) 11:23:08 INFO - [mozharness: 2017-05-04 18:23:08.459123Z] Running read-buildbot-config step. 11:23:08 INFO - Running pre-action listener: _resource_record_pre_action 11:23:08 INFO - Running main action method: read_buildbot_config 11:23:08 INFO - Using buildbot properties: 11:23:08 INFO - { 11:23:08 INFO - "project": "", 11:23:08 INFO - "product": "firefox", 11:23:08 INFO - "script_repo_revision": "production", 11:23:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:23:08 INFO - "repository": "", 11:23:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:23:08 INFO - "buildid": "20170504095619", 11:23:08 INFO - "pgo_build": "False", 11:23:08 INFO - "basedir": "/builds/slave/test", 11:23:08 INFO - "buildnumber": 41, 11:23:08 INFO - "slavename": "t-yosemite-r7-0338", 11:23:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:23:08 INFO - "platform": "yosemite_r7", 11:23:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:23:08 INFO - "branch": "mozilla-beta", 11:23:08 INFO - "repo_path": "releases/mozilla-beta", 11:23:08 INFO - "revision": "d92d578f631e730dd9c1f1725d2ee81ccb3ed8de", 11:23:08 INFO - "stage_platform": "macosx64", 11:23:08 INFO - "builduid": "f63e2a2a030245a595809f5819453b9a", 11:23:08 INFO - "slavebuilddir": "test" 11:23:08 INFO - } 11:23:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:23:08 INFO - Running post-action listener: _resource_record_post_action 11:23:08 INFO - [mozharness: 2017-05-04 18:23:08.464951Z] Finished read-buildbot-config step (success) 11:23:08 INFO - [mozharness: 2017-05-04 18:23:08.465192Z] Running download-and-extract step. 11:23:08 INFO - Running pre-action listener: _resource_record_pre_action 11:23:08 INFO - Running main action method: download_and_extract 11:23:08 INFO - mkdir: /builds/slave/test/build/tests 11:23:08 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:08 INFO - trying https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 11:23:09 INFO - Downloaded 1287 bytes. 11:23:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:23:09 INFO - Using the following test package requirements: 11:23:09 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 11:23:09 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:23:09 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:23:09 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:23:09 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:23:09 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:23:09 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:23:09 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:23:09 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:23:09 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:23:09 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:23:09 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:23:09 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:23:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:23:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:23:09 INFO - Fetch https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:23:11 INFO - Expected file size: 51226929 11:23:11 INFO - Obtained file size: 51226929 11:23:27 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:23:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:23:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:23:27 INFO - Fetch https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:23:29 INFO - Expected file size: 51226929 11:23:29 INFO - Obtained file size: 51226929 11:23:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:23:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:23:44 INFO - Fetch https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:23:46 INFO - Expected file size: 14404449 11:23:46 INFO - Obtained file size: 14404449 11:23:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:46 INFO - trying https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 11:23:48 INFO - Downloaded 59561410 bytes. 11:23:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:23:48 INFO - mkdir: /builds/slave/test/properties 11:23:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:48 INFO - Contents: 11:23:48 INFO - build_url:https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:23:49 INFO - Running post-action listener: _resource_record_post_action 11:23:49 INFO - Running post-action listener: set_extra_try_arguments 11:23:49 INFO - [mozharness: 2017-05-04 18:23:49.292535Z] Finished download-and-extract step (success) 11:23:49 INFO - [mozharness: 2017-05-04 18:23:49.292669Z] Running populate-webroot step. 11:23:49 INFO - Running pre-action listener: _resource_record_pre_action 11:23:49 INFO - Running main action method: populate_webroot 11:23:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:49 INFO - '--tppagecycles', 11:23:49 INFO - '7'], 11:23:49 INFO - 'tests': ['tsvgm']}}, 11:23:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['damp', 'tps']}, 11:23:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'tests': ['damp', 'tps']}, 11:23:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['dromaeo_dom']}, 11:23:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['basic_compositor_video']}, 11:23:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:23:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['a11yr', 11:23:49 INFO - 'ts_paint', 11:23:49 INFO - 'tpaint', 11:23:49 INFO - 'sessionrestore', 11:23:49 INFO - 'sessionrestore_no_auto_restore', 11:23:49 INFO - 'tabpaint']}, 11:23:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:49 INFO - 'ts_paint', 11:23:49 INFO - 'tpaint', 11:23:49 INFO - 'sessionrestore', 11:23:49 INFO - 'sessionrestore_no_auto_restore', 11:23:49 INFO - 'tabpaint']}, 11:23:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:49 INFO - 'ts_paint', 11:23:49 INFO - 'tpaint', 11:23:49 INFO - 'sessionrestore', 11:23:49 INFO - 'sessionrestore_no_auto_restore', 11:23:49 INFO - 'tabpaint']}, 11:23:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:49 INFO - 'ts_paint', 11:23:49 INFO - 'tpaint', 11:23:49 INFO - 'sessionrestore', 11:23:49 INFO - 'sessionrestore_no_auto_restore', 11:23:49 INFO - 'tabpaint']}, 11:23:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['a11yr', 11:23:49 INFO - 'ts_paint', 11:23:49 INFO - 'tpaint', 11:23:49 INFO - 'sessionrestore', 11:23:49 INFO - 'sessionrestore_no_auto_restore', 11:23:49 INFO - 'tabpaint']}, 11:23:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['a11yr', 11:23:49 INFO - 'ts_paint', 11:23:49 INFO - 'tpaint', 11:23:49 INFO - 'sessionrestore', 11:23:49 INFO - 'sessionrestore_no_auto_restore', 11:23:49 INFO - 'tabpaint']}, 11:23:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['tsvgx', 11:23:49 INFO - 'tsvgr_opacity', 11:23:49 INFO - 'tart', 11:23:49 INFO - 'tscrollx', 11:23:49 INFO - 'cart', 11:23:49 INFO - 'tsvg_static']}, 11:23:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:49 INFO - 'tsvgr_opacity', 11:23:49 INFO - 'tart', 11:23:49 INFO - 'tscrollx', 11:23:49 INFO - 'cart', 11:23:49 INFO - 'tsvg_static']}, 11:23:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'talos_options': ['--disable-e10s'], 11:23:49 INFO - 'tests': ['tp5o']}, 11:23:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:23:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'talos_options': ['--disable-e10s', 11:23:49 INFO - '--xperf_path', 11:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:49 INFO - 'tests': ['tp5n']}, 11:23:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:23:49 INFO - 'talos_options': ['--xperf_path', 11:23:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:49 INFO - 'tests': ['tp5n']}}, 11:23:49 INFO - 'talos.zip': {'path': '', 11:23:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:49 INFO - Running post-action listener: _resource_record_post_action 11:23:49 INFO - [mozharness: 2017-05-04 18:23:49.311316Z] Finished populate-webroot step (success) 11:23:49 INFO - [mozharness: 2017-05-04 18:23:49.311445Z] Running create-virtualenv step. 11:23:49 INFO - Running pre-action listener: _resource_record_pre_action 11:23:49 INFO - Running main action method: create_virtualenv 11:23:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:49 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 11:23:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:49 INFO - Using real prefix '/tools/python27' 11:23:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:23:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:23:53 INFO - Installing pip.................done. 11:23:53 INFO - Return code: 0 11:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:23:53 INFO - Reading from file tmpfile_stdout 11:23:53 INFO - Output received: 11:23:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:23:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:53 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:23:53 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 11:23:53 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 11:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:53 INFO - 'HOME': '/Users/cltbld', 11:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:53 INFO - 'LOGNAME': 'cltbld', 11:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:53 INFO - 'MOZ_NO_REMOTE': '1', 11:23:53 INFO - 'NO_EM_RESTART': '1', 11:23:53 INFO - 'PAGER': '/bin/cat', 11:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:53 INFO - 'PWD': '/builds/slave/test', 11:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:53 INFO - 'SHELL': '/bin/bash', 11:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:23:53 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:53 INFO - 'USER': 'cltbld', 11:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:53 INFO - 'XPC_FLAGS': '0x0', 11:23:53 INFO - 'XPC_SERVICE_NAME': '0', 11:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:53 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 11:23:53 INFO - Cleaning up... 11:23:53 INFO - Return code: 0 11:23:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:53 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:23:53 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>=3.1.1'] in /builds/slave/test/build 11:23:53 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>=3.1.1 11:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:53 INFO - 'HOME': '/Users/cltbld', 11:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:53 INFO - 'LOGNAME': 'cltbld', 11:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:53 INFO - 'MOZ_NO_REMOTE': '1', 11:23:53 INFO - 'NO_EM_RESTART': '1', 11:23:53 INFO - 'PAGER': '/bin/cat', 11:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:53 INFO - 'PWD': '/builds/slave/test', 11:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:53 INFO - 'SHELL': '/bin/bash', 11:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:23:53 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:53 INFO - 'USER': 'cltbld', 11:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:53 INFO - 'XPC_FLAGS': '0x0', 11:23:53 INFO - 'XPC_SERVICE_NAME': '0', 11:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:53 INFO - Downloading/unpacking psutil>=3.1.1 11:23:53 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 11:23:53 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 11:23:53 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 11:23:53 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 11:23:53 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 11:23:53 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 11:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:56 INFO - Installing collected packages: psutil 11:23:56 INFO - Running setup.py install for psutil 11:23:56 INFO - building 'psutil._psutil_osx' extension 11:23:56 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 11:23:56 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 11:23:56 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 11:23:56 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 11:23:56 INFO - building 'psutil._psutil_posix' extension 11:23:56 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 11:23:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:23:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:23:56 INFO - ^ 11:23:56 INFO - 1 warning generated. 11:23:56 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 11:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:56 INFO - Successfully installed psutil 11:23:56 INFO - Cleaning up... 11:23:56 INFO - Return code: 0 11:23:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:56 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:23:56 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.3'] in /builds/slave/test/build 11:23:56 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.3 11:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:56 INFO - 'HOME': '/Users/cltbld', 11:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:56 INFO - 'LOGNAME': 'cltbld', 11:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:56 INFO - 'MOZ_NO_REMOTE': '1', 11:23:56 INFO - 'NO_EM_RESTART': '1', 11:23:56 INFO - 'PAGER': '/bin/cat', 11:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:56 INFO - 'PWD': '/builds/slave/test', 11:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:56 INFO - 'SHELL': '/bin/bash', 11:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:23:56 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:56 INFO - 'USER': 'cltbld', 11:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:56 INFO - 'XPC_FLAGS': '0x0', 11:23:56 INFO - 'XPC_SERVICE_NAME': '0', 11:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23:57 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 11:23:57 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 11:23:57 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 11:23:57 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 11:23:57 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 11:23:57 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 11:23:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:58 INFO - Installing collected packages: mozsystemmonitor 11:23:58 INFO - Running setup.py install for mozsystemmonitor 11:23:58 INFO - Successfully installed mozsystemmonitor 11:23:58 INFO - Cleaning up... 11:23:58 INFO - Return code: 0 11:23:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:58 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:23:58 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==2.5.1'] in /builds/slave/test/build 11:23:58 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==2.5.1 11:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:23:58 INFO - 'HOME': '/Users/cltbld', 11:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:23:58 INFO - 'LOGNAME': 'cltbld', 11:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:58 INFO - 'MOZ_NO_REMOTE': '1', 11:23:58 INFO - 'NO_EM_RESTART': '1', 11:23:58 INFO - 'PAGER': '/bin/cat', 11:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:58 INFO - 'PWD': '/builds/slave/test', 11:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:23:58 INFO - 'SHELL': '/bin/bash', 11:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:23:58 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:23:58 INFO - 'USER': 'cltbld', 11:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:58 INFO - 'XPC_FLAGS': '0x0', 11:23:58 INFO - 'XPC_SERVICE_NAME': '0', 11:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:23:59 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 11:23:59 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 11:23:59 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 11:23:59 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 11:23:59 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 11:23:59 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 11:24:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:00 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 11:24:00 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 11:24:00 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 11:24:00 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 11:24:00 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 11:24:00 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 11:24:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:00 INFO - warning: no files found matching '*.txt' 11:24:00 INFO - no previously-included directories found matching 'build' 11:24:00 INFO - no previously-included directories found matching 'dist' 11:24:00 INFO - no previously-included directories found matching '.git*' 11:24:00 INFO - Installing collected packages: jsonschema, functools32 11:24:00 INFO - Running setup.py install for functools32 11:24:00 INFO - warning: no files found matching '*.txt' 11:24:00 INFO - no previously-included directories found matching 'build' 11:24:00 INFO - no previously-included directories found matching 'dist' 11:24:00 INFO - no previously-included directories found matching '.git*' 11:24:00 INFO - Successfully installed jsonschema functools32 11:24:00 INFO - Cleaning up... 11:24:00 INFO - Return code: 0 11:24:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:01 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:24:01 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:24:01 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 functools32==3.2.3-2 11:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:01 INFO - 'HOME': '/Users/cltbld', 11:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:01 INFO - 'LOGNAME': 'cltbld', 11:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:01 INFO - 'MOZ_NO_REMOTE': '1', 11:24:01 INFO - 'NO_EM_RESTART': '1', 11:24:01 INFO - 'PAGER': '/bin/cat', 11:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:01 INFO - 'PWD': '/builds/slave/test', 11:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:01 INFO - 'SHELL': '/bin/bash', 11:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:01 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:01 INFO - 'USER': 'cltbld', 11:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:01 INFO - 'XPC_FLAGS': '0x0', 11:24:01 INFO - 'XPC_SERVICE_NAME': '0', 11:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:02 INFO - Cleaning up... 11:24:02 INFO - Return code: 0 11:24:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:02 INFO - 'HOME': '/Users/cltbld', 11:24:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:02 INFO - 'LOGNAME': 'cltbld', 11:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:02 INFO - 'MOZ_NO_REMOTE': '1', 11:24:02 INFO - 'NO_EM_RESTART': '1', 11:24:02 INFO - 'PAGER': '/bin/cat', 11:24:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:02 INFO - 'PWD': '/builds/slave/test', 11:24:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:02 INFO - 'SHELL': '/bin/bash', 11:24:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:02 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:02 INFO - 'USER': 'cltbld', 11:24:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:02 INFO - 'XPC_FLAGS': '0x0', 11:24:02 INFO - 'XPC_SERVICE_NAME': '0', 11:24:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 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 11:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:05 INFO - Downloading docopt-0.6.1.tar.gz 11:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:05 INFO - Running setup.py install for blobuploader 11:24:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:05 INFO - Running setup.py install for requests 11:24:06 INFO - Running setup.py install for docopt 11:24:06 INFO - Successfully installed blobuploader requests docopt 11:24:06 INFO - Cleaning up... 11:24:06 INFO - Return code: 0 11:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:06 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:24:06 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 11:24:06 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 11:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:06 INFO - 'HOME': '/Users/cltbld', 11:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:06 INFO - 'LOGNAME': 'cltbld', 11:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:06 INFO - 'MOZ_NO_REMOTE': '1', 11:24:06 INFO - 'NO_EM_RESTART': '1', 11:24:06 INFO - 'PAGER': '/bin/cat', 11:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:06 INFO - 'PWD': '/builds/slave/test', 11:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:06 INFO - 'SHELL': '/bin/bash', 11:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:06 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:06 INFO - 'USER': 'cltbld', 11:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:06 INFO - 'XPC_FLAGS': '0x0', 11:24:06 INFO - 'XPC_SERVICE_NAME': '0', 11:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:06 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-UzeChU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:06 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-R_BP9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:06 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-PNOsI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:06 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-qObQuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-a9glbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Tn4VzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-aDBeG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xpis6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-L7X5iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-iFiy8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-1SkHw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-fWF5lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-nZINVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:07 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-qHlIe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2HihdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xoSGkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:08 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-K7zj5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:08 INFO - Running setup.py install for manifestparser 11:24:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:08 INFO - Running setup.py install for mozcrash 11:24:08 INFO - Running setup.py install for mozdebug 11:24:08 INFO - Running setup.py install for mozdevice 11:24:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:08 INFO - Running setup.py install for mozfile 11:24:09 INFO - Running setup.py install for mozhttpd 11:24:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozinfo 11:24:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozInstall 11:24:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozleak 11:24:09 INFO - Running setup.py install for mozlog 11:24:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for moznetwork 11:24:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:09 INFO - Running setup.py install for mozprocess 11:24:10 INFO - Running setup.py install for mozprofile 11:24:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for mozrunner 11:24:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Running setup.py install for mozscreenshot 11:24:10 INFO - Running setup.py install for moztest 11:24:10 INFO - Running setup.py install for mozversion 11:24:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:10 INFO - Cleaning up... 11:24:10 INFO - Return code: 0 11:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:10 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:24:10 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 11:24:10 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 11:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:10 INFO - 'HOME': '/Users/cltbld', 11:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:10 INFO - 'LOGNAME': 'cltbld', 11:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:10 INFO - 'MOZ_NO_REMOTE': '1', 11:24:10 INFO - 'NO_EM_RESTART': '1', 11:24:10 INFO - 'PAGER': '/bin/cat', 11:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:10 INFO - 'PWD': '/builds/slave/test', 11:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:10 INFO - 'SHELL': '/bin/bash', 11:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:10 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:10 INFO - 'USER': 'cltbld', 11:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:10 INFO - 'XPC_FLAGS': '0x0', 11:24:10 INFO - 'XPC_SERVICE_NAME': '0', 11:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-xRpYvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yzbBP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-9U21XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ZGfHAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-G8bQ9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-LKsTcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-PoilKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:11 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)) 11:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:11 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-pmEDOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-SoyXeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-opMTrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-5yTYdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-pOp0yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-W5IlHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-TfmZCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ZK3W4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:12 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-rMNl2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:12 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ZUUVVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:12 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)) 11:24:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:13 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)) 11:24:13 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:13 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:14 INFO - Downloading blessings-1.6.tar.gz 11:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:14 INFO - Installing collected packages: blessings 11:24:14 INFO - Running setup.py install for blessings 11:24:14 INFO - Successfully installed blessings 11:24:14 INFO - Cleaning up... 11:24:14 INFO - Return code: 0 11:24:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:14 INFO - Reading from file tmpfile_stdout 11:24:14 INFO - Current package versions: 11:24:14 INFO - blessings == 1.6 11:24:14 INFO - blobuploader == 1.2.4 11:24:14 INFO - docopt == 0.6.1 11:24:14 INFO - functools32 == 3.2.3-2 11:24:14 INFO - jsonschema == 2.5.1 11:24:14 INFO - manifestparser == 1.1 11:24:14 INFO - mozInstall == 1.12 11:24:14 INFO - mozcrash == 1.0 11:24:14 INFO - mozdebug == 0.1 11:24:14 INFO - mozdevice == 0.49 11:24:14 INFO - mozfile == 1.2 11:24:14 INFO - mozhttpd == 0.7 11:24:14 INFO - mozinfo == 0.9 11:24:14 INFO - mozleak == 0.1 11:24:14 INFO - mozlog == 3.4 11:24:14 INFO - moznetwork == 0.27 11:24:14 INFO - mozprocess == 0.25 11:24:14 INFO - mozprofile == 0.28 11:24:14 INFO - mozrunner == 6.13 11:24:14 INFO - mozscreenshot == 0.1 11:24:14 INFO - mozsystemmonitor == 0.3 11:24:14 INFO - moztest == 0.8 11:24:14 INFO - mozversion == 1.4 11:24:14 INFO - psutil == 3.1.1 11:24:14 INFO - requests == 1.2.3 11:24:14 INFO - wsgiref == 0.1.2 11:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:24:14 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 11:24:14 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 11:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:14 INFO - 'HOME': '/Users/cltbld', 11:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:14 INFO - 'LOGNAME': 'cltbld', 11:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:14 INFO - 'MOZ_NO_REMOTE': '1', 11:24:14 INFO - 'NO_EM_RESTART': '1', 11:24:14 INFO - 'PAGER': '/bin/cat', 11:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:14 INFO - 'PWD': '/builds/slave/test', 11:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:14 INFO - 'SHELL': '/bin/bash', 11:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:14 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:14 INFO - 'USER': 'cltbld', 11:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:14 INFO - 'XPC_FLAGS': '0x0', 11:24:14 INFO - 'XPC_SERVICE_NAME': '0', 11:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 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)) 11:24:15 INFO - Cleaning up... 11:24:15 INFO - Return code: 0 11:24:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:15 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60dd97f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.IDcdiw8LYd/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.D7re1flfhe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 11:24:15 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 11:24:15 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 11:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:15 INFO - 'HOME': '/Users/cltbld', 11:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:15 INFO - 'LOGNAME': 'cltbld', 11:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:15 INFO - 'MOZ_NO_REMOTE': '1', 11:24:15 INFO - 'NO_EM_RESTART': '1', 11:24:15 INFO - 'PAGER': '/bin/cat', 11:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:15 INFO - 'PWD': '/builds/slave/test', 11:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:15 INFO - 'SHELL': '/bin/bash', 11:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:15 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:15 INFO - 'USER': 'cltbld', 11:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:15 INFO - 'XPC_FLAGS': '0x0', 11:24:15 INFO - 'XPC_SERVICE_NAME': '0', 11:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:15 INFO - Cleaning up... 11:24:15 INFO - Return code: 0 11:24:15 INFO - Running post-action listener: _resource_record_post_action 11:24:15 INFO - Running post-action listener: _start_resource_monitoring 11:24:15 INFO - Starting resource monitoring. 11:24:15 INFO - [mozharness: 2017-05-04 18:24:15.520415Z] Finished create-virtualenv step (success) 11:24:15 INFO - [mozharness: 2017-05-04 18:24:15.521388Z] Running install step. 11:24:15 INFO - Running pre-action listener: _resource_record_pre_action 11:24:15 INFO - Running main action method: install 11:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:15 INFO - Reading from file tmpfile_stdout 11:24:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:15 INFO - Reading from file tmpfile_stdout 11:24:15 INFO - Output received: 11:24:15 INFO - Usage: mozinstall [options] installer 11:24:15 INFO - Options: 11:24:15 INFO - -h, --help show this help message and exit 11:24:15 INFO - -d DEST, --destination=DEST 11:24:15 INFO - Directory to install application into. [default: 11:24:15 INFO - "/builds/slave/test"] 11:24:15 INFO - --app=APP Application being installed. [default: firefox] 11:24:15 INFO - mkdir: /builds/slave/test/build/application 11:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:24:30 INFO - Reading from file tmpfile_stdout 11:24:30 INFO - Output received: 11:24:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:24:30 INFO - Running post-action listener: _resource_record_post_action 11:24:30 INFO - [mozharness: 2017-05-04 18:24:30.526498Z] Finished install step (success) 11:24:30 INFO - [mozharness: 2017-05-04 18:24:30.526628Z] Running run-tests step. 11:24:30 INFO - Running pre-action listener: _resource_record_pre_action 11:24:30 INFO - Running main action method: run_tests 11:24:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:24:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:24:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:24:30 INFO - 2017-05-04 11:24:30.541 screenresolution[1907:18066] starting screenresolution argv=screenresolution get 11:24:30 INFO - 2017-05-04 11:24:30.544 screenresolution[1907:18066] Display 0: 1600x1200x32@60 11:24:30 INFO - 2017-05-04 11:24:30.549 screenresolution[1908:18068] starting screenresolution argv=screenresolution list 11:24:30 INFO - Available Modes on Display 0 11:24:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:24:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:24:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:24:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:24:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:24:30 INFO - Intel Iris: 11:24:30 INFO - Chipset Model: Intel Iris 11:24:30 INFO - Type: GPU 11:24:30 INFO - Bus: Built-In 11:24:30 INFO - VRAM (Dynamic, Max): 1536 MB 11:24:30 INFO - Vendor: Intel (0x8086) 11:24:30 INFO - Device ID: 0x0a2e 11:24:30 INFO - Revision ID: 0x0009 11:24:30 INFO - Displays: 11:24:30 INFO - Display: 11:24:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:24:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:24:30 INFO - Display Serial Number: 1600x1200 60 11:24:30 INFO - Main Display: Yes 11:24:30 INFO - Mirror: Off 11:24:30 INFO - Online: Yes 11:24:30 INFO - Rotation: Supported 11:24:30 INFO - Return code: 0 11:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:30 INFO - Python 2.7.3 11:24:30 INFO - Return code: 0 11:24:30 INFO - grabbing minidump binary from tooltool 11:24:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:30 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:30 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 11:24:30 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 11:24:30 INFO - Calling ['/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'] with output_timeout 600 11:24:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:30 INFO - Return code: 0 11:24:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:24:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:30 INFO - ENV: RUST_BACKTRACE is now 1 11:24:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:24:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 11:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 11:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDcdiw8LYd/Render', 11:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:24:30 INFO - 'HOME': '/Users/cltbld', 11:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:24:30 INFO - 'LOGNAME': 'cltbld', 11:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:30 INFO - 'MOZ_NO_REMOTE': '1', 11:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:30 INFO - 'NO_EM_RESTART': '1', 11:24:30 INFO - 'PAGER': '/bin/cat', 11:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:30 INFO - 'PWD': '/builds/slave/test', 11:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:24:30 INFO - 'RUST_BACKTRACE': '1', 11:24:30 INFO - 'SHELL': '/bin/bash', 11:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D7re1flfhe/Listeners', 11:24:30 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 11:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:24:30 INFO - 'USER': 'cltbld', 11:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:30 INFO - 'XPC_FLAGS': '0x0', 11:24:30 INFO - 'XPC_SERVICE_NAME': '0', 11:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:24:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 11:24:31 INFO - mozversion application_buildid: 20170504095619 11:24:31 INFO - mozversion application_changeset: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de 11:24:31 INFO - mozversion application_display_name: Firefox 11:24:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:31 INFO - mozversion application_name: Firefox 11:24:31 INFO - mozversion application_remotingname: firefox 11:24:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:24:31 INFO - mozversion application_vendor: Mozilla 11:24:31 INFO - mozversion application_version: 54.0 11:24:31 INFO - mozversion platform_buildid: 20170504095619 11:24:31 INFO - mozversion platform_changeset: d92d578f631e730dd9c1f1725d2ee81ccb3ed8de 11:24:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:24:31 INFO - mozversion platform_version: 54.0 11:24:31 INFO - using testdate: 1493922271 11:24:31 INFO - actual date: 1493922271 11:24:31 INFO - starting webserver on 'localhost:54211' 11:24:31 INFO - SUITE-START | Running 2 tests 11:24:31 INFO - TEST-START | dromaeo_css 11:24:31 INFO - operating with platform_type : mac_ 11:24:31 INFO - Initialising browser for dromaeo_css test... 11:24:31 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpeqDkRF/profile http://localhost:54211/getInfo.html) 11:24:33 INFO - PROCESS | 1918 | 2017-05-04 11:24:33.885 plugin-container[1921:18215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 11:24:33 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:24:33 INFO - PROCESS | 1918 | 2017-05-04 11:24:33.885 plugin-container[1921:18215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d27, name = 'com.apple.CFPasteboardClient' 11:24:33 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:24:33 INFO - PROCESS | 1918 | 2017-05-04 11:24:33.885 plugin-container[1921:18215] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:24:33 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 11:24:33 INFO - PROCESS | 1918 | colorDepth:24 11:24:33 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 11:24:33 INFO - PROCESS | 1918 | __metrics 11:24:34 ERROR - PROCESS | 1918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 11:24:34 INFO - TEST-INFO | 1918: exit 0 11:24:34 INFO - Browser initialized. 11:24:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:34 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpeqDkRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:36 INFO - PROCESS | 1922 | 2017-05-04 11:24:36.899 plugin-container[1923:18347] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 11:24:36 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:24:36 INFO - PROCESS | 1922 | 2017-05-04 11:24:36.900 plugin-container[1923:18347] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 11:24:36 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:24:36 INFO - PROCESS | 1922 | 2017-05-04 11:24:36.900 plugin-container[1923:18347] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:24:46 INFO - PROCESS | 1922 | RSS: Main: 174280704 11:24:46 INFO - PROCESS | 1922 | 11:27:49 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54211/tests/dromaeo/cssquery-ext.html) 11:27:51 INFO - PROCESS | 1922 | RSS: Main: 189046784 11:27:51 INFO - PROCESS | 1922 | 11:30:53 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-ext.html (next: http://localhost:54211/tests/dromaeo/cssquery-jquery.html) 11:30:54 INFO - PROCESS | 1922 | RSS: Main: 202428416 11:30:54 INFO - PROCESS | 1922 | 11:33:56 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54211/tests/dromaeo/cssquery-mootools.html) 11:33:56 INFO - PROCESS | 1922 | RSS: Main: 205053952 11:33:56 INFO - PROCESS | 1922 | 11:36:58 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54211/tests/dromaeo/cssquery-prototype.html) 11:36:59 INFO - PROCESS | 1922 | RSS: Main: 208269312 11:36:59 INFO - PROCESS | 1922 | 11:40:02 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54211/tests/dromaeo/cssquery-yui.html) 11:40:02 INFO - PROCESS | 1922 | RSS: Main: 210763776 11:40:02 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:54211/tests/dromaeo/cssquery-yui.html (next: http://localhost:54211/tests/dromaeo/cssquery-dojo.html) 11:43:05 INFO - PROCESS | 1922 | RSS: Main: 208871424 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | __start_tp_report 11:43:05 INFO - PROCESS | 1922 | _x_x_mozilla_page_load 11:43:05 INFO - PROCESS | 1922 | _x_x_mozilla_page_load_details 11:43:05 INFO - PROCESS | 1922 | |i|pagename|runs| 11:43:05 INFO - PROCESS | 1922 | |0;dojo.html;3587.6053634100244;3615.2588719312544;3618.1678214010776;3654.853805847766;3660.6888414484765;5059.544640982311;6187.597806142603;6203.193584833965;6246.812595622127;6251.156093927319;6193.194884664998;6248.875022499547;6251.906221406683;6252.280987686418;6273.686315684209;5553.8333849984465;5612.158176273571;5612.494875461208;5650.49145576898;5701.657900525961;5693.857653558653;5700.97382471155;5701.173329867167;5702.714864256791;5718.799842005531;5471.753771080291;5483.835484935458;5677.716114194294;5688.544916406699;5690.2033715279895;5530.640508366943;5541.224228607998;5550.639208451458;5553.7778488860395;5569.693666848301;5433.994710978482;5572.9968605650965;5601.103823388238;5604.775808967636;5649.237352957381;6279.434850863444;6287.811365659038;6293.46505547029;6296.087067375251;6304.117423560705;6326.810195694136;6461.12774775404;6571.211454625475;6625.204975402934;6648.634325112117;6469.417752402306;6502.789051722437;6551.181102362205;6568.704408301638;6607.4383677386995;6294.150289710922;6336.20797400325;6350.333215012403;6350.5554611177695;6356.205474315664;6903.447724182053;6905.930940690529;6923.792286231421;6929.930700693029;6940.236573976858;6284.277308109626;6331.05034244867;6373.1714877066615;6388.425041746265;6517.446017088506;5577.577717682047;5591.329040515164;6617.53677242598;6693.431058360094;6712.630805305755;5865.472107510344;6441.452476539453;6561.212654481493;6587.110740050032;6613.86772264552;6353.936460635427;6361.332060133712;6661.733530658719;6667.966660166765;6673.099131617267;5259.526642602184;5270.552003079704;5302.125149350314;5314.176302673091;5320.946790532123;4291.841202875206;4532.7280363178315;4686.789094490756;4725.834595789131;4740.431148262231;5320.388155362183;6243.0635404688755;6277.309495955441;6303.810885673437;6330.113784070234;5807.419258074159;6038.215032045806;6389.904151437732;6421.839454013593;6581.605103693793;5528.364238112668;6169.290531588835;6232.781852635136;6318.115463835067;6321.209848768904;5771;5779.2775903012125;5815.76736930518;5825.88348233033;5978.671173085522;6823.351781580742;6863.519553631298;6931.272216417204;6938.132733408223;6953.165620125617;6481.837954051187;6498;6785.830354240986;6805.8638827222185;6808.897866531907;5684.3747187808485;6922.5154239204785;7000.824979375557;7018.789436316919;7025.192102908027;6608.603483790988;6618.768343107968;6640.169978752656;6640.937450007976;6645.60126392418;6404.1674582304;6538.934610653832;6739.427148692416;6751.763688270887;6756.391924726799;6269.216347956505;6409.327020662763;6430.131932189094;6548.541602087808;6549.836254093686;6486.54594178403;6534.444572211415;6549.279579246184;6558.606483610808;6559.836004099936;6326.746930122744;6347.619142851444;6381.074744162163;6396.520260980352;6410.903836442364;5157.252198431282;6225.875482490234;6341.239051313687;6374.553781235269;6485.254195767358;5970.746143309953;6322.430981211713;6355.872882542416;6357.618542887441;6366.4588509977175 11:43:05 INFO - PROCESS | 1922 | |1;ext.html;641.2209165863475;685.2633419074496;722.0649259209325;996.0985308295994;998.725350528605;30054.54918176229;42358.78820605896;42407.57592424075;42451;42613.786931065304;39972;40151;40206.597934020654;40335.798321008355;40469.38122475098;9321.741564888738;9602.663906763264;9650.324477286593;9689.370190937601;9695.127438530531;9434.952825235898;9519.095685909828;9522.80954380912;9533.332666713333;9537.523123843815;9509.191718703918;9529.666461673844;9538.475383853885;9566.521673916312;9574.329796914219;9489.003654616236;9504.667336643253;9506.334556581041;9525.285603579725;9527.237820974306;9310.86033709495;9350.532473376305;9371.156595906401;9371.671991480265;9393.483358415284;34945.47581786275;35063.59745610173;35160.82419587911;35171.4724279136;35209.29581408383;3877.7867217303037;3922.117523557177;3926.5680775114715;3926.823292951824;3928.823202955874;26302.079427219956;26640.73359266421;26691.599626005627;26875.193744187705;27296.45407091847;3042.8741365694614;3197.680231976807;3287.2439338951935;3290.3583801158784;3307.1732066983254;280132;283017.7547336792;305381;337861;342107.2894635536;35591.11022224465;43879.561204388185;44392.78036098182;44459;44476.777616111714;39678.809635710975;44156;46069;46077.76961115173;46252.76873615678;14489.130652160904;14543.709125817424;14559.19924404168;14569.708605827824;14588.854111458963;12669.556565520163;12675.302858342695;12683.23900565969;12703.618891433272;12735.108542402128;9590.808183836423;9850.310478266596;12132.272063676208;12209.633710988684;12218.633440996784;5178.197379406198;5530.391656917735;5644.125160600113;5722.284714410699;5754.568407369464;935.5789894547481;1152.5620264299512;1155.7861795567846;1172.9706757331135;1183.260462211118;26549.601755973676;27293.45413091727;27619.86190069077;27668;27920.30199245035;971.4754032822339;1095.5617752898745;1099.79103970247;1143.988560114405;1360.265456653396;13487.12333698326;13884.861151388357;14107.647308817157;14140.222287774066;14229.790467810146;492593;493773;494466;494514;496372;48383;48591.028179436216;48667.5133248663;48738.025239495015;48746.75626621844;1455.44693016653;1456.0681164055013;1488.5980785188156;1495.9177245251615;1502.4516051641071;23598.528029439658;25261.621075683513;26228.344291392106;26612.733872661025;26743.866280668473;40185;40479;40558.39162412507;40560;40560.59439405568;470446;470659;471465.64267178444;472537;473127;29057;29402.117936461942;29551.55672664955;29702.108936731933;29706.40587188201;37888;38377;38765;39137.608623913395;39585.20829583335;27792;28136.29659258535;28149.43701126007;28171.57742633821;28698.856505717336;27865.44269114647;27880.58179127274;28178.577321340606;28592;28737.994170203943;32346.35307293888;32551.83724081459;32907.67092329046;33142.834285828416;33182.00453986384;25524;26353.472930541666;27425.725742742317;28523.714762852105;28944.710552895045;21508.462288442915;22769.316920492412;22903.19838805634;23136.652950205425;23453 11:43:05 INFO - PROCESS | 1922 | |2;jquery.html;427.2928303657448;444.7109378903712;444.76649758876584;447.8387780399056;451.1023064102435;19545.51136221595;20217.090230939608;21482.355529334105;21628.459288517795;21662;21807;23095.191668291613;23113.537729245407;23344.182953596628;23626.76373236267;6847.623380714072;7088.964555177217;7095.0776399068045;7120.07439032925;7384.113906331221;6037.335893051761;6812.114425124727;7588.165301816795;7721.729739459092;7760.534367937914;7455.589942553184;7641.885371719429;7662.003939487859;7685.193054729257;7685.385169186479;7395.889061664053;7635.847283054336;7644.082710074771;7716.151223365426;7752.341051010614;7215.314545118205;7457.32884040439;7498.1002279726235;7499.362554182901;7503.09962804467;26878.462430751275;27029.729702703116;27616;27753.583696244572;27911.302217444525;2914.810537315089;3052.160655819645;3070.738987186092;3100.4884194107944;3107.5183346581316;16031.519054428269;16049;16623.41818036375;17115;17269.87745796519;2091.2366986050133;2142.935711928629;2146.3668217875606;2153.5800518898823;2155.224119317045;151794;160581;173407;179046.9999999987;180214.09892950451;19502.414927552196;21279.361619151452;21281.68077478839;21433.67849482259;21468.785312146993;32742.871713339035;33123.00630981074;33414.83048093305;33418;33480.49779253313;8578.742637720878;10857;10918.50866711;10996.670099897015;11047.558097676163;9209.815803683889;9223.677171298972;9233;9389.061093890556;9410.341276110606;9615.51922403877;9812.067853553901;9824.214062874953;9910.454924979196;9942.154916832005;3578.302231064917;4114.950687574649;4231.534531201565;4238.258304796648;4239.576042395735;969.709087273815;978.9118979291756;1015.471476024708;1020.5560581147224;1054.4095306628312;17883.392928088942;18440;21198.682019769716;21911;22117.447063823533;1031.8916513766096;1033.7829055898196;1035.3322107240788;1047.6280920273346;1069.7967386196597;10889.727756805985;11044.723881903017;11257.43712814356;11348.659540213806;11361.14791390649;629526;757327;802438;810812;811595;171153.1442342805;173167;173700.1314993417;177081;182389;1276.2151276964785;1331.0616015708902;1352.9785012315836;1361.768499355112;1367.1182087553473;20154.496137596678;20575.79424205739;20925.58148837045;20980.160793568088;21046;49202.26196606982;55352.72323638356;62125;65118;65478;92905;93857.59213611664;94509.5274523623;96615.51692241494;96779.51610241903;9448.622055117718;11635.88364116348;11825.172237943261;11956.282623042298;11991.280523168638;12745;12797.744045119232;12810.359482025675;12832.743345132858;13045.934770326088;11009.559617615205;11164.553417863519;11313.490892909675;11407.486663100015;11429.142814288794;9045.050269721847;9091.681791137278;9848.655297064568;10417.42704151279;10455.79088418212;11384.715382115513;11505.94247028793;11535.884641153481;11632.53469861196;11719.48415475371;9704.369216000938;11631.825522616999;11743.706407339885;11805.350705711267;11997.76004479923;11070.723231919266;11076.833847492133;11081.113510918945;11241;11354 11:43:05 INFO - PROCESS | 1922 | |3;mootools.html;1357.5112959334645;1627.4954764023153;1634.35443000015;1638.9344426222956;1650.0512205481848;10984.725381865457;11559;11661.941690291547;11671.591494297702;11918.702032449193;11363.375014374227;11508.884911150886;11509.539618415274;11543.365114918675;11559.30644161351;2419.7701218384227;2466.4573793765435;2469.7777200052083;2478.7397323281066;2485.652008718781;2429.975700242993;2438.0004198278707;2464.864432456214;2471.962920556184;2484.142970675114;2438.9878050609723;2447.6206188040883;2460.6309053642008;2476.1333533263396;2484.85090894546;2416.6012607919674;2431.538007778516;2445.3397582652674;2451.5709750793717;2461;2408.7470815564466;2439.0853429963763;2443.621238708003;2451.521953219123;2454.803615710739;11026.173037022176;11149.331040137618;11152.498137583747;11160.386178760165;11167.441627918572;5916.349201587822;5999.610025348338;6075.908861367083;6103.816885493398;6118.60229085108;3640.3629364861044;3713.7586056906484;3728.1611637381643;3729.589745128034;3745.6441638044344;1237.7524495101015;1239.1387985350186;1254.4856608790353;1287.4013583683632;1312.7177656803833;13889.861101389059;14189.07770994882;15185.696286074217;15773.684526309524;15895.92052039744;4596.3105534170145;4694.460137084211;4774.355462012584;4809.78355973982;4834.323194752737;11378.601748938912;11927.821082683766;12112.273263604213;12127.696807579881;12179;5943.167956486095;5946.13781001761;5981;5993.430624090704;6003.249593800775;5468.890622187534;5563.666180029211;5567.276254086943;5588.133839254922;5609.971950140305;3976.446820567126;4071.4096456013713;4083.6528895044253;4093.89765255871;4106.7125301228625;1080.8378743188584;1081.7620123572801;1083.3391631105019;1095.4522738630685;1097.9890201097887;923.1783712495884;934.4907025671025;940.6848705683673;951.286535098676;998.4708104704519;6362.968185159045;6463.15978922737;6557.573757705733;6637;6852.417544508673;1031.5306535526468;1035.342557476008;1039.8128336899279;1056.4612047855496;1064.5741703318733;4071.328230841937;4132.33882578786;4157.376393540993;4248.681348898845;4255.914881702411;13756.587302380945;14307.92846035784;14328.713425731636;14349;14352.138871667734;13755.449782008607;13916;14200.928995354958;14240.928795355956;14247.931405144656;10541.525631346607;10594.523246453928;10688.625898093529;10740.516676749565;10766.815650278462;6401.770385733693;6407.327230640715;6415.775447859302;6486.318936511787;6526.24948130952;10300.484975751333;12350.691232719253;12422.751544969231;12423.937880310541;12428.875711242772;11174.553017879194;12764.29796361209;12832.165909215872;12876.484940602271;13148.145370551267;8512.489250644981;8685.565721714016;8697.21725044749;8758.693445729368;8765.430247033923;10104.393736375841;10376.844347334645;10420;10448.32085914413;10546.209034322303;8779.780505487413;8963.596638151168;8978.910210898068;9057.68298109563;9190.724278271662;8785.560721964004;8819.823603527766;8848;8871.157240062184;8905.376623636543;7576.3181313682035;7793.415493838098;7807.375409967075;7822.804429889298;7824.374050076094;4794.328793968917;5661.547076233974;5740.885182296414;5769.30768307789;5872.500837428866;5845.18167456548;5848.093545500455;5869.589128761117;5914.467697907037;5948.524118070457 11:43:05 INFO - PROCESS | 1922 | |4;prototype.html;399.8100902071518;399.8320705303773;401.06151605243724;406.1207485793259;409.07344863883293;4601.263797792346;5325.281087053247;5458.727063646812;5463.590230732691;5471.316085489314;4353.934690979638;4783.449903261126;4940.6047516198705;5149;5216.634835561512;3859.9421008684894;3999.9600103972957;4023.859164929228;4372.3878656988045;4376.1861951853025;3910.76535407875;4407.603315701586;4410.4266445362055;4427.71219870709;4435;3833.8083095845236;4027.939580906289;4145.771982540974;4421.579949904753;4432.121893343325;4350.456192975878;4362.738235705868;4370.169667763115;4392.5827046430695;4399.296112621997;3722.516072910504;3791.6018818024263;3866.428824831484;4059.8536134495707;4085.998930262075;4443.777811109431;4788.473267940523;5003.699778013331;5174.43081261061;5180.559652429511;4192.664586833076;4307.5261721210645;4997.375328083989;5066.670666406671;5126.384833819965;4634.606058485033;5386.464857515629;5429.099815064736;5663.847737859587;5669.319681638189;4000.9199816003807;4143.440635514227;4495.2133376659285;4551.95448045522;4612.109035295546;5278.709670968095;5388.282085361088;5687.772489100431;5904.586678932476;6005.369436209223;3871.787051712183;4520.864374068783;4562.977185114053;4739.952600473951;4787.055960584215;4106.1462283712535;4593.577784550531;4598.72363180228;4822.7829747661435;4828.851161233218;4587.632989360844;4891.192953162759;5061.291419201315;5197.700574856286;5208.46350326647;4796.784144713496;5247.816326428557;5694.857628559236;5704.005397166437;5717.656350757568;1383.481194552043;1610.7100721869942;1616.3938523053855;1617.85940911657;1629.8916736619212;1049.506731836036;1056.5615269663158;1213.5327898758865;1235.456399184356;1242.2918936206277;4584.33527138563;5013.373328333958;5288.995090932711;5498.1752737089755;5554.861128471821;5082.440931497532;5908.970455147697;5929.347771745104;5942.524598032147;6003.478539013625;4838.218024635848;5456.490014593332;5474.479924407175;5478.342598888079;5519.39286678465;2693.7171596982425;3079.615048118985;3093.92265193372;3097.767667424907;3110.5645209670665;5570.554355651539;5771.30744310677;5774.921028429762;6191.659458729723;6234.937650623527;4727.7163370197895;4738;5606.776103740365;5951.464368206882;6078.908816367758;5241.449647787003;5410.053240682786;5642.774289028393;5882.058870580687;6221.640314230355;5341.127682430362;5632.56413587703;5931.347551769388;5931.584789064724;5935.465808077293;4788.778861390323;5277.577793776565;5852.220195407148;5893.970530147321;5898.852528686817;5876.294844618673;5967.806438712361;6020.056862754903;6069.757209711562;6231.376862313732;4091.9590804091577;4231.259529582372;4670.4628967667795;4710.396546641753;4733.508944682414;4649.837540614846;4855.878603034811;5212.98346822366;5545.334559852843;5929.436703513159;5304.085944172297;5343.824358641093;5640.633358831663;5664.291963504562;5717.942820571741;5001.274815151855;5060.367454068241;5689;5694.943050569441;5697.316322041382;4874.195757699939;5083.712329451688;5396.542933408036;5649.576281778801;5657.547396208376;4667.883302917454;5061.493850614909;5761.107028410603;5767.855803604775;5818.534517238526;4950.504949505021;5365.787856532603;5402.702851343214;5605;5638.520725738358 11:43:05 INFO - PROCESS | 1922 | |5;yui.html;644.7453255963894;743.5760518606868;789.7867575754547;897.9012308646048;905.0994260710594;16029.118398488079;17402.82597174028;17413;17421.95468271903;17486.475405737834;15927.44253951112;16055.277512511935;16055.357785688588;16094.919525402385;16171.272292746855;974.585801034561;1001.1690297053465;1023.8924912884152;1028.675967070374;1033.9172866170688;1032.6437379104198;1032.8140934631763;1032.8812186598525;1033.81908166071;1044.9164066874632;1052.4632437456876;1065.9467026648676;1068.358984609232;1069.3530414099475;1070.7804899995483;1045.2265323660474;1060;1063.9361638301727;1064.2603390643505;1070.657389635317;780.9804754881117;792.8295416485483;795.4908858330673;795.7214974758846;797.1231645190302;17081.57296067596;17446.040467774266;17594.91202543979;17636.118194090242;17866.374676886375;14595.343209555596;14630.341634626468;14758.262086895613;14760;14803.555893323217;11748.295102293805;11761;11897.583584574584;12000.939995299968;12108.878911210862;3871.5354157500997;3896.8051597420017;4003.83984640614;4024.1146947671464;4028.697847661437;101614.49192753989;116581.417092914;117035;117485.89685986686;118436;10556.89443105559;11218.831717524243;11434.885651143548;11605.6518304451;11638.883611163948;23493.88253058758;23505.942232599573;23571.646425303636;23675.526489470114;23927;7992.200779921961;8023.879641805378;8107.473014254055;8203.507789532528;8339.693332408213;4577.771111444481;4580.748058856728;4638.373819534319;4664.230401983703;4769.689970151929;3631.2192878530714;3702.129999450127;3727.6645101940953;3729.6083911188935;3730.5709843367817;638.2691817868515;672.7813460625316;675.9662016899135;676.6616691654173;677.993220067793;702.7786247332074;724.9130104387507;758.8975488309118;759.8138456078296;767.9539227646359;10353.4305613192;10984.890151098547;10988.890111098946;11001.119910407147;11088.223824332219;729.1468981291902;734.1593875013081;752.1680871518736;754.3211110000933;763.0728664672339;4109.794510274474;4396.724949764596;4903.604774614758;5234.110201265794;5251.684898906002;109351.61159689816;110931;111932.44033779942;112540.43729781298;112781;87143.25713485821;97249;97395;100470;101147.98852011532;79608.20391796123;80415.19584804078;80944;82070.58964705258;82767.75848362279;8337.916620833714;9351.766205844908;10292.742681433025;10310.07209351162;10318.638847640297;38910;49709;49875.25187122123;50715.239271411694;50922;61713.45716357127;62338;64901.35098649142;70729;73317;13363.799543006668;13475.460981560627;13668.93165534166;13784.448622055006;13900.51348202808;14883;15554.766678500058;15593.454229101926;15768;15834.841651583798;14346.139231646135;14407.351669175121;14646.487372942322;15000.924995374953;15201.92399038042;13727.313634318045;13844.307784610528;14229.64425889361;14408.711825763636;14430.855691442952;13470.561223470893;14163.575092747235;14292.925506659836;14328.856711432752;14389.9280503601;10139.391636501834;10460.738481538023;10518.842217366899;10615;10712.410817405118;10229.08738153887;11510.827337589775;11561.942190289332;11802;11803 11:43:05 INFO - PROCESS | 1922 | __end_tp_report 11:43:05 INFO - PROCESS | 1922 | __start_cc_report 11:43:05 INFO - PROCESS | 1922 | _x_x_mozilla_cycle_collect,388 11:43:05 INFO - PROCESS | 1922 | __end_cc_report 11:43:05 INFO - PROCESS | 1922 | __startTimestamp1493923385872__endTimestamp 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | ------- Summary: start ------- 11:43:05 INFO - PROCESS | 1922 | Number of tests: 6 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | [#0] dojo.html Cycles:165 Average:6109.29 Median:6326.75 stddev:695.15 (11.0%) stddev-sans-first:668.54 11:43:05 INFO - PROCESS | 1922 | Values: 3587.6 3615.3 3618.2 3654.9 3660.7 5059.5 6187.6 6203.2 6246.8 6251.2 6193.2 6248.9 6251.9 6252.3 6273.7 5553.8 5612.2 5612.5 5650.5 5701.7 5693.9 5701.0 5701.2 5702.7 5718.8 5471.8 5483.8 5677.7 5688.5 5690.2 5530.6 5541.2 5550.6 5553.8 5569.7 5434.0 5573.0 5601.1 5604.8 5649.2 6279.4 6287.8 6293.5 6296.1 6304.1 6326.8 6461.1 6571.2 6625.2 6648.6 6469.4 6502.8 6551.2 6568.7 6607.4 6294.2 6336.2 6350.3 6350.6 6356.2 6903.4 6905.9 6923.8 6929.9 6940.2 6284.3 6331.1 6373.2 6388.4 6517.4 5577.6 5591.3 6617.5 6693.4 6712.6 5865.5 6441.5 6561.2 6587.1 6613.9 6353.9 6361.3 6661.7 6668.0 6673.1 5259.5 5270.6 5302.1 5314.2 5320.9 4291.8 4532.7 4686.8 4725.8 4740.4 5320.4 6243.1 6277.3 6303.8 6330.1 5807.4 6038.2 6389.9 6421.8 6581.6 5528.4 6169.3 6232.8 6318.1 6321.2 5771.0 5779.3 5815.8 5825.9 5978.7 6823.4 6863.5 6931.3 6938.1 6953.2 6481.8 6498.0 6785.8 6805.9 6808.9 5684.4 6922.5 7000.8 7018.8 7025.2 6608.6 6618.8 6640.2 6640.9 6645.6 6404.2 6538.9 6739.4 6751.8 6756.4 6269.2 6409.3 6430.1 6548.5 6549.8 6486.5 6534.4 6549.3 6558.6 6559.8 6326.7 6347.6 6381.1 6396.5 6410.9 5157.3 6225.9 6341.2 6374.6 6485.3 5970.7 6322.4 6355.9 6357.6 6366.5 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | [#1] ext.html Cycles:180 Average:54770.94 Median:35190.38 stddev:115474.12 (328.1%) stddev-sans-first:115726.54 11:43:05 INFO - PROCESS | 1922 | Values: 641.2 685.3 722.1 996.1 998.7 30054.5 42358.8 42407.6 42451.0 42613.8 39972.0 40151.0 40206.6 40335.8 40469.4 9321.7 9602.7 9650.3 9689.4 9695.1 9435.0 9519.1 9522.8 9533.3 9537.5 9509.2 9529.7 9538.5 9566.5 9574.3 9489.0 9504.7 9506.3 9525.3 9527.2 9310.9 9350.5 9371.2 9371.7 9393.5 34945.5 35063.6 35160.8 35171.5 35209.3 3877.8 3922.1 3926.6 3926.8 3928.8 26302.1 26640.7 26691.6 26875.2 27296.5 3042.9 3197.7 3287.2 3290.4 3307.2 280132.0 283017.8 305381.0 337861.0 342107.3 35591.1 43879.6 44392.8 44459.0 44476.8 39678.8 44156.0 46069.0 46077.8 46252.8 14489.1 14543.7 14559.2 14569.7 14588.9 12669.6 12675.3 12683.2 12703.6 12735.1 9590.8 9850.3 12132.3 12209.6 12218.6 5178.2 5530.4 5644.1 5722.3 5754.6 935.6 1152.6 1155.8 1173.0 1183.3 26549.6 27293.5 27619.9 27668.0 27920.3 971.5 1095.6 1099.8 1144.0 1360.3 13487.1 13884.9 14107.6 14140.2 14229.8 492593.0 493773.0 494466.0 494514.0 496372.0 48383.0 48591.0 48667.5 48738.0 48746.8 1455.4 1456.1 1488.6 1495.9 1502.5 23598.5 25261.6 26228.3 26612.7 26743.9 40185.0 40479.0 40558.4 40560.0 40560.6 470446.0 470659.0 471465.6 472537.0 473127.0 29057.0 29402.1 29551.6 29702.1 29706.4 37888.0 38377.0 38765.0 39137.6 39585.2 27792.0 28136.3 28149.4 28171.6 28698.9 27865.4 27880.6 28178.6 28592.0 28738.0 32346.4 32551.8 32907.7 33142.8 33182.0 25524.0 26353.5 27425.7 28523.7 28944.7 21508.5 22769.3 22903.2 23136.7 23453.0 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | [#2] jquery.html Cycles:180 Average:44852.13 Median:21859.00 stddev:128556.95 (588.1%) stddev-sans-first:128874.31 11:43:05 INFO - PROCESS | 1922 | Values: 427.3 444.7 444.8 447.8 451.1 19545.5 20217.1 21482.4 21628.5 21662.0 21807.0 23095.2 23113.5 23344.2 23626.8 6847.6 7089.0 7095.1 7120.1 7384.1 6037.3 6812.1 7588.2 7721.7 7760.5 7455.6 7641.9 7662.0 7685.2 7685.4 7395.9 7635.8 7644.1 7716.2 7752.3 7215.3 7457.3 7498.1 7499.4 7503.1 26878.5 27029.7 27616.0 27753.6 27911.3 2914.8 3052.2 3070.7 3100.5 3107.5 16031.5 16049.0 16623.4 17115.0 17269.9 2091.2 2142.9 2146.4 2153.6 2155.2 151794.0 160581.0 173407.0 179047.0 180214.1 19502.4 21279.4 21281.7 21433.7 21468.8 32742.9 33123.0 33414.8 33418.0 33480.5 8578.7 10857.0 10918.5 10996.7 11047.6 9209.8 9223.7 9233.0 9389.1 9410.3 9615.5 9812.1 9824.2 9910.5 9942.2 3578.3 4115.0 4231.5 4238.3 4239.6 969.7 978.9 1015.5 1020.6 1054.4 17883.4 18440.0 21198.7 21911.0 22117.4 1031.9 1033.8 1035.3 1047.6 1069.8 10889.7 11044.7 11257.4 11348.7 11361.1 629526.0 757327.0 802438.0 810812.0 811595.0 171153.1 173167.0 173700.1 177081.0 182389.0 1276.2 1331.1 1353.0 1361.8 1367.1 20154.5 20575.8 20925.6 20980.2 21046.0 49202.3 55352.7 62125.0 65118.0 65478.0 92905.0 93857.6 94509.5 96615.5 96779.5 9448.6 11635.9 11825.2 11956.3 11991.3 12745.0 12797.7 12810.4 12832.7 13045.9 11009.6 11164.6 11313.5 11407.5 11429.1 9045.1 9091.7 9848.7 10417.4 10455.8 11384.7 11505.9 11535.9 11632.5 11719.5 9704.4 11631.8 11743.7 11805.4 11997.8 11070.7 11076.8 11081.1 11241.0 11354.0 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | [#3] mootools.html Cycles:180 Average:6839.67 Median:2462.93 stddev:4275.32 (173.6%) stddev-sans-first:4267.46 11:43:05 INFO - PROCESS | 1922 | Values: 1357.5 1627.5 1634.4 1638.9 1650.1 10984.7 11559.0 11661.9 11671.6 11918.7 11363.4 11508.9 11509.5 11543.4 11559.3 2419.8 2466.5 2469.8 2478.7 2485.7 2430.0 2438.0 2464.9 2472.0 2484.1 2439.0 2447.6 2460.6 2476.1 2484.9 2416.6 2431.5 2445.3 2451.6 2461.0 2408.7 2439.1 2443.6 2451.5 2454.8 11026.2 11149.3 11152.5 11160.4 11167.4 5916.3 5999.6 6075.9 6103.8 6118.6 3640.4 3713.8 3728.2 3729.6 3745.6 1237.8 1239.1 1254.5 1287.4 1312.7 13889.9 14189.1 15185.7 15773.7 15895.9 4596.3 4694.5 4774.4 4809.8 4834.3 11378.6 11927.8 12112.3 12127.7 12179.0 5943.2 5946.1 5981.0 5993.4 6003.2 5468.9 5563.7 5567.3 5588.1 5610.0 3976.4 4071.4 4083.7 4093.9 4106.7 1080.8 1081.8 1083.3 1095.5 1098.0 923.2 934.5 940.7 951.3 998.5 6363.0 6463.2 6557.6 6637.0 6852.4 1031.5 1035.3 1039.8 1056.5 1064.6 4071.3 4132.3 4157.4 4248.7 4255.9 13756.6 14307.9 14328.7 14349.0 14352.1 13755.4 13916.0 14200.9 14240.9 14247.9 10541.5 10594.5 10688.6 10740.5 10766.8 6401.8 6407.3 6415.8 6486.3 6526.2 10300.5 12350.7 12422.8 12423.9 12428.9 11174.6 12764.3 12832.2 12876.5 13148.1 8512.5 8685.6 8697.2 8758.7 8765.4 10104.4 10376.8 10420.0 10448.3 10546.2 8779.8 8963.6 8978.9 9057.7 9190.7 8785.6 8819.8 8848.0 8871.2 8905.4 7576.3 7793.4 7807.4 7822.8 7824.4 4794.3 5661.5 5740.9 5769.3 5872.5 5845.2 5848.1 5869.6 5914.5 5948.5 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | [#4] prototype.html Cycles:180 Average:4700.46 Median:5036.87 stddev:1317.61 (26.2%) stddev-sans-first:1281.15 11:43:05 INFO - PROCESS | 1922 | Values: 399.8 399.8 401.1 406.1 409.1 4601.3 5325.3 5458.7 5463.6 5471.3 4353.9 4783.4 4940.6 5149.0 5216.6 3859.9 4000.0 4023.9 4372.4 4376.2 3910.8 4407.6 4410.4 4427.7 4435.0 3833.8 4027.9 4145.8 4421.6 4432.1 4350.5 4362.7 4370.2 4392.6 4399.3 3722.5 3791.6 3866.4 4059.9 4086.0 4443.8 4788.5 5003.7 5174.4 5180.6 4192.7 4307.5 4997.4 5066.7 5126.4 4634.6 5386.5 5429.1 5663.8 5669.3 4000.9 4143.4 4495.2 4552.0 4612.1 5278.7 5388.3 5687.8 5904.6 6005.4 3871.8 4520.9 4563.0 4740.0 4787.1 4106.1 4593.6 4598.7 4822.8 4828.9 4587.6 4891.2 5061.3 5197.7 5208.5 4796.8 5247.8 5694.9 5704.0 5717.7 1383.5 1610.7 1616.4 1617.9 1629.9 1049.5 1056.6 1213.5 1235.5 1242.3 4584.3 5013.4 5289.0 5498.2 5554.9 5082.4 5909.0 5929.3 5942.5 6003.5 4838.2 5456.5 5474.5 5478.3 5519.4 2693.7 3079.6 3093.9 3097.8 3110.6 5570.6 5771.3 5774.9 6191.7 6234.9 4727.7 4738.0 5606.8 5951.5 6078.9 5241.4 5410.1 5642.8 5882.1 6221.6 5341.1 5632.6 5931.3 5931.6 5935.5 4788.8 5277.6 5852.2 5894.0 5898.9 5876.3 5967.8 6020.1 6069.8 6231.4 4092.0 4231.3 4670.5 4710.4 4733.5 4649.8 4855.9 5213.0 5545.3 5929.4 5304.1 5343.8 5640.6 5664.3 5717.9 5001.3 5060.4 5689.0 5694.9 5697.3 4874.2 5083.7 5396.5 5649.6 5657.5 4667.9 5061.5 5761.1 5767.9 5818.5 4950.5 5365.8 5402.7 5605.0 5638.5 11:43:05 INFO - PROCESS | 1922 | 11:43:05 INFO - PROCESS | 1922 | [#5] yui.html Cycles:180 Average:21618.04 Median:16042.20 stddev:31264.71 (194.9%) stddev-sans-first:31312.75 11:43:05 INFO - PROCESS | 1922 | Values: 644.7 743.6 789.8 897.9 905.1 16029.1 17402.8 17413.0 17422.0 17486.5 15927.4 16055.3 16055.4 16094.9 16171.3 974.6 1001.2 1023.9 1028.7 1033.9 1032.6 1032.8 1032.9 1033.8 1044.9 1052.5 1065.9 1068.4 1069.4 1070.8 1045.2 1060.0 1063.9 1064.3 1070.7 781.0 792.8 795.5 795.7 797.1 17081.6 17446.0 17594.9 17636.1 17866.4 14595.3 14630.3 14758.3 14760.0 14803.6 11748.3 11761.0 11897.6 12000.9 12108.9 3871.5 3896.8 4003.8 4024.1 4028.7 101614.5 116581.4 117035.0 117485.9 118436.0 10556.9 11218.8 11434.9 11605.7 11638.9 23493.9 23505.9 23571.6 23675.5 23927.0 7992.2 8023.9 8107.5 8203.5 8339.7 4577.8 4580.7 4638.4 4664.2 4769.7 3631.2 3702.1 3727.7 3729.6 3730.6 638.3 672.8 676.0 676.7 678.0 702.8 724.9 758.9 759.8 768.0 10353.4 10984.9 10988.9 11001.1 11088.2 729.1 734.2 752.2 754.3 763.1 4109.8 4396.7 4903.6 5234.1 5251.7 109351.6 110931.0 111932.4 112540.4 112781.0 87143.3 97249.0 97395.0 100470.0 101148.0 79608.2 80415.2 80944.0 82070.6 82767.8 8337.9 9351.8 10292.7 10310.1 10318.6 38910.0 49709.0 49875.3 50715.2 50922.0 61713.5 62338.0 64901.4 70729.0 73317.0 13363.8 13475.5 13668.9 13784.4 13900.5 14883.0 15554.8 15593.5 15768.0 15834.8 14346.1 14407.4 14646.5 15000.9 15201.9 13727.3 13844.3 14229.6 14408.7 14430.9 13470.6 14163.6 14292.9 14328.9 14389.9 10139.4 10460.7 10518.8 10615.0 10712.4 10229.1 11510.8 11561.9 11802.0 11803.0 11:43:05 INFO - PROCESS | 1922 | -------- Summary: end -------- 11:43:05 INFO - PROCESS | 1922 | 11:43:06 INFO - TEST-INFO | 1922: exit 0 11:43:06 INFO - TEST-OK | dromaeo_css | took 1115284ms 11:43:06 INFO - TEST-START | kraken 11:43:06 INFO - operating with platform_type : mac_ 11:43:06 INFO - Initialising browser for kraken test... 11:43:06 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp9zDVWw/profile http://localhost:54211/getInfo.html) 11:43:09 INFO - PROCESS | 1929 | 2017-05-04 11:43:09.054 plugin-container[1931:20464] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 11:43:09 INFO - PROCESS | 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:43:09 INFO - PROCESS | 1929 | 2017-05-04 11:43:09.054 plugin-container[1931:20464] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 11:43:09 INFO - PROCESS | 1929 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:43:09 INFO - PROCESS | 1929 | 2017-05-04 11:43:09.054 plugin-container[1931:20464] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:43:09 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 11:43:09 INFO - PROCESS | 1929 | colorDepth:24 11:43:09 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 11:43:09 INFO - PROCESS | 1929 | __metrics 11:43:09 ERROR - PROCESS | 1929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 11:43:09 INFO - TEST-INFO | 1929: exit 0 11:43:09 INFO - Browser initialized. 11:43:09 INFO - Running cycle 1/1 for kraken test... 11:43:09 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp9zDVWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:12 INFO - PROCESS | 1932 | 2017-05-04 11:43:12.140 plugin-container[1933:20586] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 11:43:12 INFO - PROCESS | 1932 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:43:12 INFO - PROCESS | 1932 | 2017-05-04 11:43:12.141 plugin-container[1933:20586] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x861f, name = 'com.apple.CFPasteboardClient' 11:43:12 INFO - PROCESS | 1932 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:43:12 INFO - PROCESS | 1932 | 2017-05-04 11:43:12.141 plugin-container[1933:20586] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:43:22 INFO - PROCESS | 1932 | RSS: Main: 174460928 11:43:22 INFO - PROCESS | 1932 | 11:43:24 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:25 INFO - PROCESS | 1932 | RSS: Main: 187944960 11:43:25 INFO - PROCESS | 1932 | 11:43:28 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-dft) 11:43:29 INFO - PROCESS | 1932 | RSS: Main: 195985408 11:43:29 INFO - PROCESS | 1932 | 11:43:32 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-fft) 11:43:33 INFO - PROCESS | 1932 | RSS: Main: 197566464 11:43:33 INFO - PROCESS | 1932 | 11:43:35 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54211/tests/kraken/driver.html?testName=audio-oscillator) 11:43:35 INFO - PROCESS | 1932 | RSS: Main: 199352320 11:43:35 INFO - PROCESS | 1932 | 11:43:37 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:43:38 INFO - PROCESS | 1932 | RSS: Main: 199704576 11:43:38 INFO - PROCESS | 1932 | 11:43:41 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54211/tests/kraken/driver.html?testName=imaging-darkroom) 11:43:42 INFO - PROCESS | 1932 | RSS: Main: 203931648 11:43:42 INFO - PROCESS | 1932 | 11:43:45 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54211/tests/kraken/driver.html?testName=imaging-desaturate) 11:43:46 INFO - PROCESS | 1932 | RSS: Main: 203542528 11:43:46 INFO - PROCESS | 1932 | 11:43:49 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54211/tests/kraken/driver.html?testName=json-parse-financial) 11:43:49 INFO - PROCESS | 1932 | RSS: Main: 204853248 11:43:49 INFO - PROCESS | 1932 | 11:43:51 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:43:52 INFO - PROCESS | 1932 | RSS: Main: 204546048 11:43:52 INFO - PROCESS | 1932 | 11:43:54 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:43:55 INFO - PROCESS | 1932 | RSS: Main: 204533760 11:43:55 INFO - PROCESS | 1932 | 11:43:57 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:57 INFO - PROCESS | 1932 | RSS: Main: 204566528 11:43:57 INFO - PROCESS | 1932 | 11:44:00 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:01 INFO - PROCESS | 1932 | RSS: Main: 204959744 11:44:01 INFO - PROCESS | 1932 | 11:44:04 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:04 INFO - PROCESS | 1932 | RSS: Main: 205193216 11:44:04 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | Cycle 1(1): loaded http://localhost:54211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54211/tests/kraken/driver.html?testName=ai-astar) 11:44:06 INFO - PROCESS | 1932 | RSS: Main: 206921728 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | __start_tp_report 11:44:06 INFO - PROCESS | 1932 | _x_x_mozilla_page_load 11:44:06 INFO - PROCESS | 1932 | _x_x_mozilla_page_load_details 11:44:06 INFO - PROCESS | 1932 | |i|pagename|runs| 11:44:06 INFO - PROCESS | 1932 | |0;ai-astar;133;174;152;120;119;119;120;119;119;120 11:44:06 INFO - PROCESS | 1932 | |1;audio-beat-detection;159;143;147;132;141;133;105;102;145;106 11:44:06 INFO - PROCESS | 1932 | |2;audio-dft;195;208;270;193;281;280;197;199;197;200 11:44:06 INFO - PROCESS | 1932 | |3;audio-fft;78;51;83;109;90;86;59;61;70;62 11:44:06 INFO - PROCESS | 1932 | |4;audio-oscillator;95;69;82;72;71;69;80;71;94;113 11:44:06 INFO - PROCESS | 1932 | |5;imaging-gaussian-blur;98;133;134;89;100;87;88;88;111;135 11:44:06 INFO - PROCESS | 1932 | |6;imaging-darkroom;96;105;152;112;93;138;153;111;125;153 11:44:06 INFO - PROCESS | 1932 | |7;imaging-desaturate;86;135;145;98;144;80;139;146;110;92 11:44:06 INFO - PROCESS | 1932 | |8;json-parse-financial;63;72;91;104;104;69;67;68;68;68 11:44:06 INFO - PROCESS | 1932 | |9;json-stringify-tinderbox;57;65;58;68;66;70;78;86;84;85 11:44:06 INFO - PROCESS | 1932 | |10;stanford-crypto-aes;76;89;86;103;76;84;83;83;83;90 11:44:06 INFO - PROCESS | 1932 | |11;stanford-crypto-ccm;140;138;147;132;138;134;140;139;181;138 11:44:06 INFO - PROCESS | 1932 | |12;stanford-crypto-pbkdf2;164;165;162;164;170;163;166;166;167;162 11:44:06 INFO - PROCESS | 1932 | |13;stanford-crypto-sha256-iterative;64;65;63;65;65;77;60;60;61;64 11:44:06 INFO - PROCESS | 1932 | __end_tp_report 11:44:06 INFO - PROCESS | 1932 | __start_cc_report 11:44:06 INFO - PROCESS | 1932 | _x_x_mozilla_cycle_collect,985 11:44:06 INFO - PROCESS | 1932 | __end_cc_report 11:44:06 INFO - PROCESS | 1932 | __startTimestamp1493923446665__endTimestamp 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | ------- Summary: start ------- 11:44:06 INFO - PROCESS | 1932 | Number of tests: 14 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#0] ai-astar Cycles:10 Average:129.50 Median:120.00 stddev:18.89 (15.7%) stddev-sans-first:19.99 11:44:06 INFO - PROCESS | 1932 | Values: 133.0 174.0 152.0 120.0 119.0 119.0 120.0 119.0 119.0 120.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:142.00 stddev:20.07 (14.1%) stddev-sans-first:18.62 11:44:06 INFO - PROCESS | 1932 | Values: 159.0 143.0 147.0 132.0 141.0 133.0 105.0 102.0 145.0 106.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#2] audio-dft Cycles:10 Average:222.00 Median:204.00 stddev:38.27 (18.8%) stddev-sans-first:39.32 11:44:06 INFO - PROCESS | 1932 | Values: 195.0 208.0 270.0 193.0 281.0 280.0 197.0 199.0 197.0 200.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.00 stddev:17.63 (23.8%) stddev-sans-first:18.66 11:44:06 INFO - PROCESS | 1932 | Values: 78.0 51.0 83.0 109.0 90.0 86.0 59.0 61.0 70.0 62.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:76.00 stddev:14.74 (19.4%) stddev-sans-first:14.82 11:44:06 INFO - PROCESS | 1932 | Values: 95.0 69.0 82.0 72.0 71.0 69.0 80.0 71.0 94.0 113.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#5] imaging-gaussian-blur Cycles:10 Average:106.30 Median:87.50 stddev:20.48 (23.4%) stddev-sans-first:21.50 11:44:06 INFO - PROCESS | 1932 | Values: 98.0 133.0 134.0 89.0 100.0 87.0 88.0 88.0 111.0 135.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#6] imaging-darkroom Cycles:10 Average:123.80 Median:152.50 stddev:23.76 (15.6%) stddev-sans-first:22.98 11:44:06 INFO - PROCESS | 1932 | Values: 96.0 105.0 152.0 112.0 93.0 138.0 153.0 111.0 125.0 153.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#7] imaging-desaturate Cycles:10 Average:117.50 Median:113.00 stddev:26.92 (23.8%) stddev-sans-first:26.03 11:44:06 INFO - PROCESS | 1932 | Values: 86.0 135.0 145.0 98.0 144.0 80.0 139.0 146.0 110.0 92.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#8] json-parse-financial Cycles:10 Average:77.40 Median:68.00 stddev:15.92 (23.4%) stddev-sans-first:16.01 11:44:06 INFO - PROCESS | 1932 | Values: 63.0 72.0 91.0 104.0 104.0 69.0 67.0 68.0 68.0 68.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:74.00 stddev:10.90 (14.7%) stddev-sans-first:10.19 11:44:06 INFO - PROCESS | 1932 | Values: 57.0 65.0 58.0 68.0 66.0 70.0 78.0 86.0 84.0 85.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:83.50 stddev:7.75 (9.3%) stddev-sans-first:7.45 11:44:06 INFO - PROCESS | 1932 | Values: 76.0 89.0 86.0 103.0 76.0 84.0 83.0 83.0 83.0 90.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:139.50 stddev:14.02 (10.1%) stddev-sans-first:14.84 11:44:06 INFO - PROCESS | 1932 | Values: 140.0 138.0 147.0 132.0 138.0 134.0 140.0 139.0 181.0 138.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:2.47 (1.5%) stddev-sans-first:2.60 11:44:06 INFO - PROCESS | 1932 | Values: 164.0 165.0 162.0 164.0 170.0 163.0 166.0 166.0 167.0 162.0 11:44:06 INFO - PROCESS | 1932 | 11:44:06 INFO - PROCESS | 1932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:4.86 (7.5%) stddev-sans-first:5.15 11:44:06 INFO - PROCESS | 1932 | Values: 64.0 65.0 63.0 65.0 65.0 77.0 60.0 60.0 61.0 64.0 11:44:06 INFO - PROCESS | 1932 | -------- Summary: end -------- 11:44:06 INFO - PROCESS | 1932 | 11:44:07 INFO - TEST-INFO | 1932: exit 0 11:44:07 INFO - TEST-OK | kraken | took 61040ms 11:44:07 INFO - SUITE-END | took 1176s 11:44:07 INFO - Completed test suite (00:19:36) 11:44:07 INFO - javascript benchmark 11:44:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7873.241466719567, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3587.6053634100244, 3615.2588719312544, 3618.1678214010776, 3654.853805847766, 3660.6888414484765, 5059.544640982311, 6187.597806142603, 6203.193584833965, 6246.812595622127, 6251.156093927319, 6193.194884664998, 6248.875022499547, 6251.906221406683, 6252.280987686418, 6273.686315684209, 5553.8333849984465, 5612.158176273571, 5612.494875461208, 5650.49145576898, 5701.657900525961, 5693.857653558653, 5700.97382471155, 5701.173329867167, 5702.714864256791, 5718.799842005531, 5471.753771080291, 5483.835484935458, 5677.716114194294, 5688.544916406699, 5690.2033715279895, 5530.640508366943, 5541.224228607998, 5550.639208451458, 5553.7778488860395, 5569.693666848301, 5433.994710978482, 5572.9968605650965, 5601.103823388238, 5604.775808967636, 5649.237352957381, 6279.434850863444, 6287.811365659038, 6293.46505547029, 6296.087067375251, 6304.117423560705, 6326.810195694136, 6461.12774775404, 6571.211454625475, 6625.204975402934, 6648.634325112117, 6469.417752402306, 6502.789051722437, 6551.181102362205, 6568.704408301638, 6607.4383677386995, 6294.150289710922, 6336.20797400325, 6350.333215012403, 6350.5554611177695, 6356.205474315664, 6903.447724182053, 6905.930940690529, 6923.792286231421, 6929.930700693029, 6940.236573976858, 6284.277308109626, 6331.05034244867, 6373.1714877066615, 6388.425041746265, 6517.446017088506, 5577.577717682047, 5591.329040515164, 6617.53677242598, 6693.431058360094, 6712.630805305755, 5865.472107510344, 6441.452476539453, 6561.212654481493, 6587.110740050032, 6613.86772264552, 6353.936460635427, 6361.332060133712, 6661.733530658719, 6667.966660166765, 6673.099131617267, 5259.526642602184, 5270.552003079704, 5302.125149350314, 5314.176302673091, 5320.946790532123, 4291.841202875206, 4532.7280363178315, 4686.789094490756, 4725.834595789131, 4740.431148262231, 5320.388155362183, 6243.0635404688755, 6277.309495955441, 6303.810885673437, 6330.113784070234, 5807.419258074159, 6038.215032045806, 6389.904151437732, 6421.839454013593, 6581.605103693793, 5528.364238112668, 6169.290531588835, 6232.781852635136, 6318.115463835067, 6321.209848768904, 5771.0, 5779.2775903012125, 5815.76736930518, 5825.88348233033, 5978.671173085522, 6823.351781580742, 6863.519553631298, 6931.272216417204, 6938.132733408223, 6953.165620125617, 6481.837954051187, 6498.0, 6785.830354240986, 6805.8638827222185, 6808.897866531907, 5684.3747187808485, 6922.5154239204785, 7000.824979375557, 7018.789436316919, 7025.192102908027, 6608.603483790988, 6618.768343107968, 6640.169978752656, 6640.937450007976, 6645.60126392418, 6404.1674582304, 6538.934610653832, 6739.427148692416, 6751.763688270887, 6756.391924726799, 6269.216347956505, 6409.327020662763, 6430.131932189094, 6548.541602087808, 6549.836254093686, 6486.54594178403, 6534.444572211415, 6549.279579246184, 6558.606483610808, 6559.836004099936, 6326.746930122744, 6347.619142851444, 6381.074744162163, 6396.520260980352, 6410.903836442364, 5157.252198431282, 6225.875482490234, 6341.239051313687, 6374.553781235269, 6485.254195767358, 5970.746143309953, 6322.430981211713, 6355.872882542416, 6357.618542887441, 6366.4588509977175], "value": 6067.109609633248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.2209165863475, 685.2633419074496, 722.0649259209325, 996.0985308295994, 998.725350528605, 30054.54918176229, 42358.78820605896, 42407.57592424075, 42451.0, 42613.786931065304, 39972.0, 40151.0, 40206.597934020654, 40335.798321008355, 40469.38122475098, 9321.741564888738, 9602.663906763264, 9650.324477286593, 9689.370190937601, 9695.127438530531, 9434.952825235898, 9519.095685909828, 9522.80954380912, 9533.332666713333, 9537.523123843815, 9509.191718703918, 9529.666461673844, 9538.475383853885, 9566.521673916312, 9574.329796914219, 9489.003654616236, 9504.667336643253, 9506.334556581041, 9525.285603579725, 9527.237820974306, 9310.86033709495, 9350.532473376305, 9371.156595906401, 9371.671991480265, 9393.483358415284, 34945.47581786275, 35063.59745610173, 35160.82419587911, 35171.4724279136, 35209.29581408383, 3877.7867217303037, 3922.117523557177, 3926.5680775114715, 3926.823292951824, 3928.823202955874, 26302.079427219956, 26640.73359266421, 26691.599626005627, 26875.193744187705, 27296.45407091847, 3042.8741365694614, 3197.680231976807, 3287.2439338951935, 3290.3583801158784, 3307.1732066983254, 280132.0, 283017.7547336792, 305381.0, 337861.0, 342107.2894635536, 35591.11022224465, 43879.561204388185, 44392.78036098182, 44459.0, 44476.777616111714, 39678.809635710975, 44156.0, 46069.0, 46077.76961115173, 46252.76873615678, 14489.130652160904, 14543.709125817424, 14559.19924404168, 14569.708605827824, 14588.854111458963, 12669.556565520163, 12675.302858342695, 12683.23900565969, 12703.618891433272, 12735.108542402128, 9590.808183836423, 9850.310478266596, 12132.272063676208, 12209.633710988684, 12218.633440996784, 5178.197379406198, 5530.391656917735, 5644.125160600113, 5722.284714410699, 5754.568407369464, 935.5789894547481, 1152.5620264299512, 1155.7861795567846, 1172.9706757331135, 1183.260462211118, 26549.601755973676, 27293.45413091727, 27619.86190069077, 27668.0, 27920.30199245035, 971.4754032822339, 1095.5617752898745, 1099.79103970247, 1143.988560114405, 1360.265456653396, 13487.12333698326, 13884.861151388357, 14107.647308817157, 14140.222287774066, 14229.790467810146, 492593.0, 493773.0, 494466.0, 494514.0, 496372.0, 48383.0, 48591.028179436216, 48667.5133248663, 48738.025239495015, 48746.75626621844, 1455.44693016653, 1456.0681164055013, 1488.5980785188156, 1495.9177245251615, 1502.4516051641071, 23598.528029439658, 25261.621075683513, 26228.344291392106, 26612.733872661025, 26743.866280668473, 40185.0, 40479.0, 40558.39162412507, 40560.0, 40560.59439405568, 470446.0, 470659.0, 471465.64267178444, 472537.0, 473127.0, 29057.0, 29402.117936461942, 29551.55672664955, 29702.108936731933, 29706.40587188201, 37888.0, 38377.0, 38765.0, 39137.608623913395, 39585.20829583335, 27792.0, 28136.29659258535, 28149.43701126007, 28171.57742633821, 28698.856505717336, 27865.44269114647, 27880.58179127274, 28178.577321340606, 28592.0, 28737.994170203943, 32346.35307293888, 32551.83724081459, 32907.67092329046, 33142.834285828416, 33182.00453986384, 25524.0, 26353.472930541666, 27425.725742742317, 28523.714762852105, 28944.710552895045, 21508.462288442915, 22769.316920492412, 22903.19838805634, 23136.652950205425, 23453.0], "value": 17904.00800193784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.2928303657448, 444.7109378903712, 444.76649758876584, 447.8387780399056, 451.1023064102435, 19545.51136221595, 20217.090230939608, 21482.355529334105, 21628.459288517795, 21662.0, 21807.0, 23095.191668291613, 23113.537729245407, 23344.182953596628, 23626.76373236267, 6847.623380714072, 7088.964555177217, 7095.0776399068045, 7120.07439032925, 7384.113906331221, 6037.335893051761, 6812.114425124727, 7588.165301816795, 7721.729739459092, 7760.534367937914, 7455.589942553184, 7641.885371719429, 7662.003939487859, 7685.193054729257, 7685.385169186479, 7395.889061664053, 7635.847283054336, 7644.082710074771, 7716.151223365426, 7752.341051010614, 7215.314545118205, 7457.32884040439, 7498.1002279726235, 7499.362554182901, 7503.09962804467, 26878.462430751275, 27029.729702703116, 27616.0, 27753.583696244572, 27911.302217444525, 2914.810537315089, 3052.160655819645, 3070.738987186092, 3100.4884194107944, 3107.5183346581316, 16031.519054428269, 16049.0, 16623.41818036375, 17115.0, 17269.87745796519, 2091.2366986050133, 2142.935711928629, 2146.3668217875606, 2153.5800518898823, 2155.224119317045, 151794.0, 160581.0, 173407.0, 179046.9999999987, 180214.09892950451, 19502.414927552196, 21279.361619151452, 21281.68077478839, 21433.67849482259, 21468.785312146993, 32742.871713339035, 33123.00630981074, 33414.83048093305, 33418.0, 33480.49779253313, 8578.742637720878, 10857.0, 10918.50866711, 10996.670099897015, 11047.558097676163, 9209.815803683889, 9223.677171298972, 9233.0, 9389.061093890556, 9410.341276110606, 9615.51922403877, 9812.067853553901, 9824.214062874953, 9910.454924979196, 9942.154916832005, 3578.302231064917, 4114.950687574649, 4231.534531201565, 4238.258304796648, 4239.576042395735, 969.709087273815, 978.9118979291756, 1015.471476024708, 1020.5560581147224, 1054.4095306628312, 17883.392928088942, 18440.0, 21198.682019769716, 21911.0, 22117.447063823533, 1031.8916513766096, 1033.7829055898196, 1035.3322107240788, 1047.6280920273346, 1069.7967386196597, 10889.727756805985, 11044.723881903017, 11257.43712814356, 11348.659540213806, 11361.14791390649, 629526.0, 757327.0, 802438.0, 810812.0, 811595.0, 171153.1442342805, 173167.0, 173700.1314993417, 177081.0, 182389.0, 1276.2151276964785, 1331.0616015708902, 1352.9785012315836, 1361.768499355112, 1367.1182087553473, 20154.496137596678, 20575.79424205739, 20925.58148837045, 20980.160793568088, 21046.0, 49202.26196606982, 55352.72323638356, 62125.0, 65118.0, 65478.0, 92905.0, 93857.59213611664, 94509.5274523623, 96615.51692241494, 96779.51610241903, 9448.622055117718, 11635.88364116348, 11825.172237943261, 11956.282623042298, 11991.280523168638, 12745.0, 12797.744045119232, 12810.359482025675, 12832.743345132858, 13045.934770326088, 11009.559617615205, 11164.553417863519, 11313.490892909675, 11407.486663100015, 11429.142814288794, 9045.050269721847, 9091.681791137278, 9848.655297064568, 10417.42704151279, 10455.79088418212, 11384.715382115513, 11505.94247028793, 11535.884641153481, 11632.53469861196, 11719.48415475371, 9704.369216000938, 11631.825522616999, 11743.706407339885, 11805.350705711267, 11997.76004479923, 11070.723231919266, 11076.833847492133, 11081.113510918945, 11241.0, 11354.0], "value": 12025.01994466371, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.5112959334645, 1627.4954764023153, 1634.35443000015, 1638.9344426222956, 1650.0512205481848, 10984.725381865457, 11559.0, 11661.941690291547, 11671.591494297702, 11918.702032449193, 11363.375014374227, 11508.884911150886, 11509.539618415274, 11543.365114918675, 11559.30644161351, 2419.7701218384227, 2466.4573793765435, 2469.7777200052083, 2478.7397323281066, 2485.652008718781, 2429.975700242993, 2438.0004198278707, 2464.864432456214, 2471.962920556184, 2484.142970675114, 2438.9878050609723, 2447.6206188040883, 2460.6309053642008, 2476.1333533263396, 2484.85090894546, 2416.6012607919674, 2431.538007778516, 2445.3397582652674, 2451.5709750793717, 2461.0, 2408.7470815564466, 2439.0853429963763, 2443.621238708003, 2451.521953219123, 2454.803615710739, 11026.173037022176, 11149.331040137618, 11152.498137583747, 11160.386178760165, 11167.441627918572, 5916.349201587822, 5999.610025348338, 6075.908861367083, 6103.816885493398, 6118.60229085108, 3640.3629364861044, 3713.7586056906484, 3728.1611637381643, 3729.589745128034, 3745.6441638044344, 1237.7524495101015, 1239.1387985350186, 1254.4856608790353, 1287.4013583683632, 1312.7177656803833, 13889.861101389059, 14189.07770994882, 15185.696286074217, 15773.684526309524, 15895.92052039744, 4596.3105534170145, 4694.460137084211, 4774.355462012584, 4809.78355973982, 4834.323194752737, 11378.601748938912, 11927.821082683766, 12112.273263604213, 12127.696807579881, 12179.0, 5943.167956486095, 5946.13781001761, 5981.0, 5993.430624090704, 6003.249593800775, 5468.890622187534, 5563.666180029211, 5567.276254086943, 5588.133839254922, 5609.971950140305, 3976.446820567126, 4071.4096456013713, 4083.6528895044253, 4093.89765255871, 4106.7125301228625, 1080.8378743188584, 1081.7620123572801, 1083.3391631105019, 1095.4522738630685, 1097.9890201097887, 923.1783712495884, 934.4907025671025, 940.6848705683673, 951.286535098676, 998.4708104704519, 6362.968185159045, 6463.15978922737, 6557.573757705733, 6637.0, 6852.417544508673, 1031.5306535526468, 1035.342557476008, 1039.8128336899279, 1056.4612047855496, 1064.5741703318733, 4071.328230841937, 4132.33882578786, 4157.376393540993, 4248.681348898845, 4255.914881702411, 13756.587302380945, 14307.92846035784, 14328.713425731636, 14349.0, 14352.138871667734, 13755.449782008607, 13916.0, 14200.928995354958, 14240.928795355956, 14247.931405144656, 10541.525631346607, 10594.523246453928, 10688.625898093529, 10740.516676749565, 10766.815650278462, 6401.770385733693, 6407.327230640715, 6415.775447859302, 6486.318936511787, 6526.24948130952, 10300.484975751333, 12350.691232719253, 12422.751544969231, 12423.937880310541, 12428.875711242772, 11174.553017879194, 12764.29796361209, 12832.165909215872, 12876.484940602271, 13148.145370551267, 8512.489250644981, 8685.565721714016, 8697.21725044749, 8758.693445729368, 8765.430247033923, 10104.393736375841, 10376.844347334645, 10420.0, 10448.32085914413, 10546.209034322303, 8779.780505487413, 8963.596638151168, 8978.910210898068, 9057.68298109563, 9190.724278271662, 8785.560721964004, 8819.823603527766, 8848.0, 8871.157240062184, 8905.376623636543, 7576.3181313682035, 7793.415493838098, 7807.375409967075, 7822.804429889298, 7824.374050076094, 4794.328793968917, 5661.547076233974, 5740.885182296414, 5769.30768307789, 5872.500837428866, 5845.18167456548, 5848.093545500455, 5869.589128761117, 5914.467697907037, 5948.524118070457], "value": 5234.8903083886735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.8100902071518, 399.8320705303773, 401.06151605243724, 406.1207485793259, 409.07344863883293, 4601.263797792346, 5325.281087053247, 5458.727063646812, 5463.590230732691, 5471.316085489314, 4353.934690979638, 4783.449903261126, 4940.6047516198705, 5149.0, 5216.634835561512, 3859.9421008684894, 3999.9600103972957, 4023.859164929228, 4372.3878656988045, 4376.1861951853025, 3910.76535407875, 4407.603315701586, 4410.4266445362055, 4427.71219870709, 4435.0, 3833.8083095845236, 4027.939580906289, 4145.771982540974, 4421.579949904753, 4432.121893343325, 4350.456192975878, 4362.738235705868, 4370.169667763115, 4392.5827046430695, 4399.296112621997, 3722.516072910504, 3791.6018818024263, 3866.428824831484, 4059.8536134495707, 4085.998930262075, 4443.777811109431, 4788.473267940523, 5003.699778013331, 5174.43081261061, 5180.559652429511, 4192.664586833076, 4307.5261721210645, 4997.375328083989, 5066.670666406671, 5126.384833819965, 4634.606058485033, 5386.464857515629, 5429.099815064736, 5663.847737859587, 5669.319681638189, 4000.9199816003807, 4143.440635514227, 4495.2133376659285, 4551.95448045522, 4612.109035295546, 5278.709670968095, 5388.282085361088, 5687.772489100431, 5904.586678932476, 6005.369436209223, 3871.787051712183, 4520.864374068783, 4562.977185114053, 4739.952600473951, 4787.055960584215, 4106.1462283712535, 4593.577784550531, 4598.72363180228, 4822.7829747661435, 4828.851161233218, 4587.632989360844, 4891.192953162759, 5061.291419201315, 5197.700574856286, 5208.46350326647, 4796.784144713496, 5247.816326428557, 5694.857628559236, 5704.005397166437, 5717.656350757568, 1383.481194552043, 1610.7100721869942, 1616.3938523053855, 1617.85940911657, 1629.8916736619212, 1049.506731836036, 1056.5615269663158, 1213.5327898758865, 1235.456399184356, 1242.2918936206277, 4584.33527138563, 5013.373328333958, 5288.995090932711, 5498.1752737089755, 5554.861128471821, 5082.440931497532, 5908.970455147697, 5929.347771745104, 5942.524598032147, 6003.478539013625, 4838.218024635848, 5456.490014593332, 5474.479924407175, 5478.342598888079, 5519.39286678465, 2693.7171596982425, 3079.615048118985, 3093.92265193372, 3097.767667424907, 3110.5645209670665, 5570.554355651539, 5771.30744310677, 5774.921028429762, 6191.659458729723, 6234.937650623527, 4727.7163370197895, 4738.0, 5606.776103740365, 5951.464368206882, 6078.908816367758, 5241.449647787003, 5410.053240682786, 5642.774289028393, 5882.058870580687, 6221.640314230355, 5341.127682430362, 5632.56413587703, 5931.347551769388, 5931.584789064724, 5935.465808077293, 4788.778861390323, 5277.577793776565, 5852.220195407148, 5893.970530147321, 5898.852528686817, 5876.294844618673, 5967.806438712361, 6020.056862754903, 6069.757209711562, 6231.376862313732, 4091.9590804091577, 4231.259529582372, 4670.4628967667795, 4710.396546641753, 4733.508944682414, 4649.837540614846, 4855.878603034811, 5212.98346822366, 5545.334559852843, 5929.436703513159, 5304.085944172297, 5343.824358641093, 5640.633358831663, 5664.291963504562, 5717.942820571741, 5001.274815151855, 5060.367454068241, 5689.0, 5694.943050569441, 5697.316322041382, 4874.195757699939, 5083.712329451688, 5396.542933408036, 5649.576281778801, 5657.547396208376, 4667.883302917454, 5061.493850614909, 5761.107028410603, 5767.855803604775, 5818.534517238526, 4950.504949505021, 5365.787856532603, 5402.702851343214, 5605.0, 5638.520725738358], "value": 4322.685101286681, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.7453255963894, 743.5760518606868, 789.7867575754547, 897.9012308646048, 905.0994260710594, 16029.118398488079, 17402.82597174028, 17413.0, 17421.95468271903, 17486.475405737834, 15927.44253951112, 16055.277512511935, 16055.357785688588, 16094.919525402385, 16171.272292746855, 974.585801034561, 1001.1690297053465, 1023.8924912884152, 1028.675967070374, 1033.9172866170688, 1032.6437379104198, 1032.8140934631763, 1032.8812186598525, 1033.81908166071, 1044.9164066874632, 1052.4632437456876, 1065.9467026648676, 1068.358984609232, 1069.3530414099475, 1070.7804899995483, 1045.2265323660474, 1060.0, 1063.9361638301727, 1064.2603390643505, 1070.657389635317, 780.9804754881117, 792.8295416485483, 795.4908858330673, 795.7214974758846, 797.1231645190302, 17081.57296067596, 17446.040467774266, 17594.91202543979, 17636.118194090242, 17866.374676886375, 14595.343209555596, 14630.341634626468, 14758.262086895613, 14760.0, 14803.555893323217, 11748.295102293805, 11761.0, 11897.583584574584, 12000.939995299968, 12108.878911210862, 3871.5354157500997, 3896.8051597420017, 4003.83984640614, 4024.1146947671464, 4028.697847661437, 101614.49192753989, 116581.417092914, 117035.0, 117485.89685986686, 118436.0, 10556.89443105559, 11218.831717524243, 11434.885651143548, 11605.6518304451, 11638.883611163948, 23493.88253058758, 23505.942232599573, 23571.646425303636, 23675.526489470114, 23927.0, 7992.200779921961, 8023.879641805378, 8107.473014254055, 8203.507789532528, 8339.693332408213, 4577.771111444481, 4580.748058856728, 4638.373819534319, 4664.230401983703, 4769.689970151929, 3631.2192878530714, 3702.129999450127, 3727.6645101940953, 3729.6083911188935, 3730.5709843367817, 638.2691817868515, 672.7813460625316, 675.9662016899135, 676.6616691654173, 677.993220067793, 702.7786247332074, 724.9130104387507, 758.8975488309118, 759.8138456078296, 767.9539227646359, 10353.4305613192, 10984.890151098547, 10988.890111098946, 11001.119910407147, 11088.223824332219, 729.1468981291902, 734.1593875013081, 752.1680871518736, 754.3211110000933, 763.0728664672339, 4109.794510274474, 4396.724949764596, 4903.604774614758, 5234.110201265794, 5251.684898906002, 109351.61159689816, 110931.0, 111932.44033779942, 112540.43729781298, 112781.0, 87143.25713485821, 97249.0, 97395.0, 100470.0, 101147.98852011532, 79608.20391796123, 80415.19584804078, 80944.0, 82070.58964705258, 82767.75848362279, 8337.916620833714, 9351.766205844908, 10292.742681433025, 10310.07209351162, 10318.638847640297, 38910.0, 49709.0, 49875.25187122123, 50715.239271411694, 50922.0, 61713.45716357127, 62338.0, 64901.35098649142, 70729.0, 73317.0, 13363.799543006668, 13475.460981560627, 13668.93165534166, 13784.448622055006, 13900.51348202808, 14883.0, 15554.766678500058, 15593.454229101926, 15768.0, 15834.841651583798, 14346.139231646135, 14407.351669175121, 14646.487372942322, 15000.924995374953, 15201.92399038042, 13727.313634318045, 13844.307784610528, 14229.64425889361, 14408.711825763636, 14430.855691442952, 13470.561223470893, 14163.575092747235, 14292.925506659836, 14328.856711432752, 14389.9280503601, 10139.391636501834, 10460.738481538023, 10518.842217366899, 10615.0, 10712.410817405118, 10229.08738153887, 11510.827337589775, 11561.942190289332, 11802.0, 11803.0], "value": 8057.568814753086, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 174.0, 152.0, 120.0, 119.0, 119.0, 120.0, 119.0, 119.0, 120.0], "value": 129.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 143.0, 147.0, 132.0, 141.0, 133.0, 105.0, 102.0, 145.0, 106.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 208.0, 270.0, 193.0, 281.0, 280.0, 197.0, 199.0, 197.0, 200.0], "value": 222.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 51.0, 83.0, 109.0, 90.0, 86.0, 59.0, 61.0, 70.0, 62.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 69.0, 82.0, 72.0, 71.0, 69.0, 80.0, 71.0, 94.0, 113.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 133.0, 134.0, 89.0, 100.0, 87.0, 88.0, 88.0, 111.0, 135.0], "value": 106.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 152.0, 112.0, 93.0, 138.0, 153.0, 111.0, 125.0, 153.0], "value": 123.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 135.0, 145.0, 98.0, 144.0, 80.0, 139.0, 146.0, 110.0, 92.0], "value": 117.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 91.0, 104.0, 104.0, 69.0, 67.0, 68.0, 68.0, 68.0], "value": 77.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 65.0, 58.0, 68.0, 66.0, 70.0, 78.0, 86.0, 84.0, 85.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 89.0, 86.0, 103.0, 76.0, 84.0, 83.0, 83.0, 83.0, 90.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 147.0, 132.0, 138.0, 134.0, 140.0, 139.0, 181.0, 138.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 164.0, 170.0, 163.0, 166.0, 166.0, 167.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 65.0, 65.0, 77.0, 60.0, 60.0, 61.0, 64.0], "value": 64.4, "unit": "score"}]}]} 11:44:07 INFO - Return code: 0 11:44:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:07 ERROR - # TBPL SUCCESS # 11:44:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:44:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:44:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:44:07 INFO - 2017-05-04 11:44:07.995 screenresolution[1937:20970] starting screenresolution argv=screenresolution get 11:44:07 INFO - 2017-05-04 11:44:07.997 screenresolution[1937:20970] Display 0: 1600x1200x32@60 11:44:08 INFO - 2017-05-04 11:44:08.004 screenresolution[1938:20973] starting screenresolution argv=screenresolution list 11:44:08 INFO - Available Modes on Display 0 11:44:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:44:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:44:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:44:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:44:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:44:08 INFO - Intel Iris: 11:44:08 INFO - Chipset Model: Intel Iris 11:44:08 INFO - Type: GPU 11:44:08 INFO - Bus: Built-In 11:44:08 INFO - VRAM (Dynamic, Max): 1536 MB 11:44:08 INFO - Vendor: Intel (0x8086) 11:44:08 INFO - Device ID: 0x0a2e 11:44:08 INFO - Revision ID: 0x0009 11:44:08 INFO - Displays: 11:44:08 INFO - Display: 11:44:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:44:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:44:08 INFO - Display Serial Number: 1600x1200 60 11:44:08 INFO - Main Display: Yes 11:44:08 INFO - Mirror: Off 11:44:08 INFO - Online: Yes 11:44:08 INFO - Rotation: Supported 11:44:08 INFO - Return code: 0 11:44:08 INFO - Running post-action listener: _resource_record_post_action 11:44:08 INFO - [mozharness: 2017-05-04 18:44:08.240189Z] Finished run-tests step (success) 11:44:08 INFO - Running post-run listener: _resource_record_post_run 11:44:08 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 1298432; Write bytes: 426465792; Read time: 16; Write time: 1448 11:44:08 INFO - TinderboxPrint: CPU usage
54.3% 11:44:08 INFO - TinderboxPrint: I/O read bytes / time
1,298,432 / 16 11:44:08 INFO - TinderboxPrint: I/O write bytes / time
426,465,792 / 1,448 11:44:08 INFO - TinderboxPrint: CPU idle
2,179.0 (45.7%) 11:44:08 INFO - TinderboxPrint: CPU system
952.0 (20.0%) 11:44:08 INFO - TinderboxPrint: CPU user
1,638.6 (34.4%) 11:44:08 INFO - TinderboxPrint: Swap in / out
123,564,032 / 0 11:44:08 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 108388864; Write bytes: 104826880; Read time: 9857; Write time: 241 11:44:08 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1298432; Write bytes: 300802560; Read time: 16; Write time: 1145 11:44:08 INFO - Running post-run listener: _upload_blobber_files 11:44:08 INFO - Blob upload gear active. 11:44:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:08 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 11:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:09 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:44:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:09 INFO - (blobuploader) - INFO - Done attempting. 11:44:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:44:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:44:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:11 INFO - (blobuploader) - INFO - Done attempting. 11:44:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:44:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:44:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:12 INFO - (blobuploader) - INFO - Done attempting. 11:44:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:14 INFO - (blobuploader) - INFO - Done attempting. 11:44:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:14 INFO - Return code: 0 11:44:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2f99b106951cb19a41efcf0265762303099448d79ade479120420e9b68813a8a93b861f601788390773a3f3b33ab5902538f35aab3ca74c4143f434185a4596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a989c9a626d255c7e253e6ef416d8307f796c044e5a83c4844ace8c87433fd3a971df4a12dca3fdb6ef5620433593d6ebcf7cc7dda347cbc41c82c5ce0bb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/570caddc7aa58c4a9045c7ab8ee156b35bfbee53f5521319b8d6b6b396d4539c6b1619ddae2249b55ce4b337fe156954d25373dbe2ece0b5f88b9ee04bf12d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa567f165034d4339eaacbdbbaeed0c82286eed67dfd5da8f9d93ea7fbf4efd9467b4dbaacac76ea0fa51b077ae44a36fb7716eaef368fc920ddfdb6541cb1d8"} 11:44:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:14 INFO - Contents: 11:44:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2f99b106951cb19a41efcf0265762303099448d79ade479120420e9b68813a8a93b861f601788390773a3f3b33ab5902538f35aab3ca74c4143f434185a4596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a989c9a626d255c7e253e6ef416d8307f796c044e5a83c4844ace8c87433fd3a971df4a12dca3fdb6ef5620433593d6ebcf7cc7dda347cbc41c82c5ce0bb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/570caddc7aa58c4a9045c7ab8ee156b35bfbee53f5521319b8d6b6b396d4539c6b1619ddae2249b55ce4b337fe156954d25373dbe2ece0b5f88b9ee04bf12d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa567f165034d4339eaacbdbbaeed0c82286eed67dfd5da8f9d93ea7fbf4efd9467b4dbaacac76ea0fa51b077ae44a36fb7716eaef368fc920ddfdb6541cb1d8"} 11:44:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:14 INFO - Copying logs to upload dir... 11:44:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.378630 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-05-04 11:44:14.640111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 11:44:14.644415) ========= 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.IDcdiw8LYd/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.D7re1flfhe/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2f99b106951cb19a41efcf0265762303099448d79ade479120420e9b68813a8a93b861f601788390773a3f3b33ab5902538f35aab3ca74c4143f434185a4596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a989c9a626d255c7e253e6ef416d8307f796c044e5a83c4844ace8c87433fd3a971df4a12dca3fdb6ef5620433593d6ebcf7cc7dda347cbc41c82c5ce0bb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/570caddc7aa58c4a9045c7ab8ee156b35bfbee53f5521319b8d6b6b396d4539c6b1619ddae2249b55ce4b337fe156954d25373dbe2ece0b5f88b9ee04bf12d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa567f165034d4339eaacbdbbaeed0c82286eed67dfd5da8f9d93ea7fbf4efd9467b4dbaacac76ea0fa51b077ae44a36fb7716eaef368fc920ddfdb6541cb1d8"} build_url:https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010586 build_url: 'https://queue.taskcluster.net/v1/task/T85dkPStQ9SkiZbXFFudew/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2f99b106951cb19a41efcf0265762303099448d79ade479120420e9b68813a8a93b861f601788390773a3f3b33ab5902538f35aab3ca74c4143f434185a4596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25a989c9a626d255c7e253e6ef416d8307f796c044e5a83c4844ace8c87433fd3a971df4a12dca3fdb6ef5620433593d6ebcf7cc7dda347cbc41c82c5ce0bb01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/570caddc7aa58c4a9045c7ab8ee156b35bfbee53f5521319b8d6b6b396d4539c6b1619ddae2249b55ce4b337fe156954d25373dbe2ece0b5f88b9ee04bf12d2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa567f165034d4339eaacbdbbaeed0c82286eed67dfd5da8f9d93ea7fbf4efd9467b4dbaacac76ea0fa51b077ae44a36fb7716eaef368fc920ddfdb6541cb1d8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 11:44:14.686346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:44:14.686964) ========= 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.IDcdiw8LYd/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.D7re1flfhe/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005021 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 11:44:14.738263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 11:44:14.738829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 11:44:14.739431) ========= ========= Total master_lag: 0.20 =========