builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0364 starttime: 1479378925.22 results: success (0) buildid: 20161117004016 builduid: bf7f5794d2c24b5fa40e4a339be5456a revision: d86e4e3d92b082d1e86160ac182f8c73cd80597a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.222919) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.223410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.223711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.248884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.249335) ========= 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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 02:35:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2016-11-17 02:35:25 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.383073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.383459) ========= 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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.025025 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:25.431650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 02:35:25.432038) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d86e4e3d92b082d1e86160ac182f8c73cd80597a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d86e4e3d92b082d1e86160ac182f8c73cd80597a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uZUL6V7tpi/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.9QsJjYPO9c/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 02:35:25,530 truncating revision to first 12 chars 2016-11-17 02:35:25,530 Setting DEBUG logging. 2016-11-17 02:35:25,530 attempt 1/10 2016-11-17 02:35:25,530 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d86e4e3d92b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 02:35:26,325 unpacking tar archive at: mozilla-aurora-d86e4e3d92b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050404 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 02:35:26.504727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:26.505059) ========= script_repo_revision: d86e4e3d92b082d1e86160ac182f8c73cd80597a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:26.505480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:26.505770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 02:35:26.524208) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-17 02:35:26.524644) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uZUL6V7tpi/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.9QsJjYPO9c/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:35:26 INFO - MultiFileLogger online at 20161117 02:35:26 in /builds/slave/test 02:35:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:35:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:35:26 INFO - {'append_to_log': False, 02:35:26 INFO - 'base_work_dir': '/builds/slave/test', 02:35:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:35:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:35:26 INFO - 'branch': 'Mozilla-Aurora', 02:35:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:35:26 INFO - 'config_files': ('talos/mac_config.py',), 02:35:26 INFO - 'default_actions': ('clobber', 02:35:26 INFO - 'read-buildbot-config', 02:35:26 INFO - 'download-and-extract', 02:35:26 INFO - 'populate-webroot', 02:35:26 INFO - 'create-virtualenv', 02:35:26 INFO - 'install', 02:35:26 INFO - 'run-tests'), 02:35:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:35:26 INFO - 'download_minidump_stackwalk': True, 02:35:26 INFO - 'download_symbols': 'ondemand', 02:35:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:35:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:35:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:35:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:35:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:35:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:35:26 INFO - 'installer_path': 'installer.exe', 02:35:26 INFO - 'log_level': 'info', 02:35:26 INFO - 'log_name': 'talos', 02:35:26 INFO - 'log_to_console': True, 02:35:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:35:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:35:26 INFO - 'opt_config_files': (), 02:35:26 INFO - 'pip_index': False, 02:35:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:35:26 INFO - 'cmd': ('bash', 02:35:26 INFO - '-c', 02:35:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:35:26 INFO - 'enabled': True, 02:35:26 INFO - 'halt_on_failure': False, 02:35:26 INFO - 'name': 'check_screen_resolution'},), 02:35:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:35:26 INFO - 'cmd': ('bash', 02:35:26 INFO - '-c', 02:35:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:35:26 INFO - 'enabled': True, 02:35:26 INFO - 'halt_on_failure': False, 02:35:26 INFO - 'name': 'check_screen_resolution'},), 02:35:26 INFO - 'run_cmd_checks_enabled': True, 02:35:26 INFO - 'sps_profile': False, 02:35:26 INFO - 'sps_profile_interval': 0, 02:35:26 INFO - 'suite': 'dromaeojs-e10s', 02:35:26 INFO - 'system_bits': '32', 02:35:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:35:26 INFO - 'title': 't-yosemite-r7-0364', 02:35:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:35:26 INFO - 'use_talos_json': True, 02:35:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:35:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:35:26 INFO - 'work_dir': 'build'} 02:35:26 INFO - [mozharness: 2016-11-17 10:35:26.730772Z] Running clobber step. 02:35:26 INFO - Running pre-action listener: _resource_record_pre_action 02:35:26 INFO - Running main action method: clobber 02:35:26 INFO - rmtree: /builds/slave/test/build 02:35:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:29 INFO - Running post-action listener: _resource_record_post_action 02:35:29 INFO - [mozharness: 2016-11-17 10:35:29.044043Z] Finished clobber step (success) 02:35:29 INFO - [mozharness: 2016-11-17 10:35:29.044172Z] Running read-buildbot-config step. 02:35:29 INFO - Running pre-action listener: _resource_record_pre_action 02:35:29 INFO - Running main action method: read_buildbot_config 02:35:29 INFO - Using buildbot properties: 02:35:29 INFO - { 02:35:29 INFO - "project": "", 02:35:29 INFO - "product": "firefox", 02:35:29 INFO - "script_repo_revision": "production", 02:35:29 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:35:29 INFO - "repository": "", 02:35:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:35:29 INFO - "buildid": "20161117004016", 02:35:29 INFO - "stage_platform": "macosx64", 02:35:29 INFO - "basedir": "/builds/slave/test", 02:35:29 INFO - "nightly_build": "True", 02:35:29 INFO - "buildnumber": 22, 02:35:29 INFO - "slavename": "t-yosemite-r7-0364", 02:35:29 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:35:29 INFO - "platform": "yosemite_r7", 02:35:29 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:35:29 INFO - "branch": "mozilla-aurora", 02:35:29 INFO - "repo_path": "releases/mozilla-aurora", 02:35:29 INFO - "revision": "d86e4e3d92b082d1e86160ac182f8c73cd80597a", 02:35:29 INFO - "pgo_build": "False", 02:35:29 INFO - "builduid": "bf7f5794d2c24b5fa40e4a339be5456a", 02:35:29 INFO - "slavebuilddir": "test" 02:35:29 INFO - } 02:35:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:35:29 INFO - Running post-action listener: _resource_record_post_action 02:35:29 INFO - [mozharness: 2016-11-17 10:35:29.047476Z] Finished read-buildbot-config step (success) 02:35:29 INFO - [mozharness: 2016-11-17 10:35:29.047564Z] Running download-and-extract step. 02:35:29 INFO - Running pre-action listener: _resource_record_pre_action 02:35:29 INFO - Running main action method: download_and_extract 02:35:29 INFO - mkdir: /builds/slave/test/build/tests 02:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:29 INFO - trying https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:35:29 INFO - Downloading https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:35:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:35:30 INFO - Downloaded 1199 bytes. 02:35:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:35:30 INFO - Using the following test package requirements: 02:35:30 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:35:30 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:35:30 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:35:30 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'jsshell-mac.zip'], 02:35:30 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:35:30 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:35:30 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:35:30 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:35:30 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:35:30 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:35:30 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:35:30 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:35:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:35:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:35:30 INFO - Fetch https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:35:30 INFO - Http code: 200 02:35:30 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 02:35:30 INFO - x-amz-cf-id: fNcwkX80JGDxGVVe9iTMIKG1qxs36uOFnNfdwqLlTKVYRx3PSodXKA== 02:35:30 INFO - x-amz-version-id: 9DyKGYxcLHdgyScG8X41_iYA8YO.94ho 02:35:31 INFO - Expected file size: 16327487 02:35:31 INFO - Obtained file size: 16327487 02:35:38 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:35:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:35:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:35:38 INFO - Fetch https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:35:38 INFO - Http code: 200 02:35:38 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 02:35:38 INFO - x-amz-cf-id: xB6XOaIICmrAU-0TBhzBbVp-6AxGf7Sa4sL1YdQ1aJLIWx-84FZicQ== 02:35:38 INFO - x-amz-version-id: 9DyKGYxcLHdgyScG8X41_iYA8YO.94ho 02:35:39 INFO - Expected file size: 16327487 02:35:39 INFO - Obtained file size: 16327487 02:35:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:35:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:35:45 INFO - Fetch https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:35:46 INFO - Http code: 200 02:35:46 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 02:35:46 INFO - x-amz-cf-id: PyBsYhLrKrxg-boFZTHExxqpDYgpYd8gS2vciX1730GIJXGx8lvBGQ== 02:35:46 INFO - x-amz-version-id: EIIOcxxAk4nPYtREhWsROXQa5CeMwaYp 02:35:47 INFO - Expected file size: 14409038 02:35:47 INFO - Obtained file size: 14409038 02:35:47 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')]} 02:35:47 INFO - trying https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:35:47 INFO - Downloading https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:35:50 INFO - Downloaded 114585099 bytes. 02:35:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:35:50 INFO - mkdir: /builds/slave/test/properties 02:35:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:35:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:35:50 INFO - Contents: 02:35:50 INFO - build_url:https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:35:51 INFO - Running post-action listener: _resource_record_post_action 02:35:51 INFO - Running post-action listener: set_extra_try_arguments 02:35:51 INFO - [mozharness: 2016-11-17 10:35:51.514486Z] Finished download-and-extract step (success) 02:35:51 INFO - [mozharness: 2016-11-17 10:35:51.514591Z] Running populate-webroot step. 02:35:51 INFO - Running pre-action listener: _resource_record_pre_action 02:35:51 INFO - Running main action method: populate_webroot 02:35:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:35:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:35:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:35:51 INFO - '--tppagecycles', 02:35:51 INFO - '7'], 02:35:51 INFO - 'tests': ['tsvgm']}}, 02:35:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:35:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:35:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:35:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:35:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:35:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['damp', 'tps']}, 02:35:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'tests': ['damp', 'tps']}, 02:35:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['dromaeo_dom']}, 02:35:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:35:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['basic_compositor_video']}, 02:35:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:35:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['a11yr', 02:35:51 INFO - 'ts_paint', 02:35:51 INFO - 'tpaint', 02:35:51 INFO - 'sessionrestore', 02:35:51 INFO - 'sessionrestore_no_auto_restore', 02:35:51 INFO - 'tabpaint']}, 02:35:51 INFO - 'other-e10s': {'tests': ['a11yr', 02:35:51 INFO - 'ts_paint', 02:35:51 INFO - 'tpaint', 02:35:51 INFO - 'sessionrestore', 02:35:51 INFO - 'sessionrestore_no_auto_restore', 02:35:51 INFO - 'tabpaint']}, 02:35:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:35:51 INFO - 'ts_paint', 02:35:51 INFO - 'tpaint', 02:35:51 INFO - 'sessionrestore', 02:35:51 INFO - 'sessionrestore_no_auto_restore', 02:35:51 INFO - 'tabpaint']}, 02:35:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:35:51 INFO - 'ts_paint', 02:35:51 INFO - 'tpaint', 02:35:51 INFO - 'sessionrestore', 02:35:51 INFO - 'sessionrestore_no_auto_restore', 02:35:51 INFO - 'tabpaint']}, 02:35:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['a11yr', 02:35:51 INFO - 'ts_paint', 02:35:51 INFO - 'tpaint', 02:35:51 INFO - 'sessionrestore', 02:35:51 INFO - 'sessionrestore_no_auto_restore', 02:35:51 INFO - 'tabpaint']}, 02:35:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['a11yr', 02:35:51 INFO - 'ts_paint', 02:35:51 INFO - 'tpaint', 02:35:51 INFO - 'sessionrestore', 02:35:51 INFO - 'sessionrestore_no_auto_restore', 02:35:51 INFO - 'tabpaint']}, 02:35:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['tsvgx', 02:35:51 INFO - 'tsvgr_opacity', 02:35:51 INFO - 'tart', 02:35:51 INFO - 'tscrollx', 02:35:51 INFO - 'cart']}, 02:35:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:35:51 INFO - 'tsvgr_opacity', 02:35:51 INFO - 'tart', 02:35:51 INFO - 'tscrollx', 02:35:51 INFO - 'cart']}, 02:35:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'talos_options': ['--disable-e10s'], 02:35:51 INFO - 'tests': ['tp5o']}, 02:35:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'tests': ['tp5o']}, 02:35:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'talos_options': ['--disable-e10s', 02:35:51 INFO - '--xperf_path', 02:35:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:51 INFO - 'tests': ['tp5n']}, 02:35:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:35:51 INFO - 'talos_options': ['--xperf_path', 02:35:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:35:51 INFO - 'tests': ['tp5n']}}, 02:35:51 INFO - 'talos.zip': {'path': '', 02:35:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:35:51 INFO - Running post-action listener: _resource_record_post_action 02:35:51 INFO - [mozharness: 2016-11-17 10:35:51.533735Z] Finished populate-webroot step (success) 02:35:51 INFO - [mozharness: 2016-11-17 10:35:51.533850Z] Running create-virtualenv step. 02:35:51 INFO - Running pre-action listener: _resource_record_pre_action 02:35:51 INFO - Running main action method: create_virtualenv 02:35:51 INFO - Creating virtualenv /builds/slave/test/build/venv 02:35:51 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 02:35:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:35:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:35:51 INFO - Using real prefix '/tools/python27' 02:35:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:35:52 INFO - Installing distribute.............................................................................................................................................................................................done. 02:35:55 INFO - Installing pip.................done. 02:35:55 INFO - Return code: 0 02:35:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:35:55 INFO - Reading from file tmpfile_stdout 02:35:55 INFO - Output received: 02:35:55 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) 02:35:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:55 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:35:55 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 02:35:55 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 02:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:55 INFO - 'HOME': '/Users/cltbld', 02:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:55 INFO - 'LOGNAME': 'cltbld', 02:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:55 INFO - 'MOZ_NO_REMOTE': '1', 02:35:55 INFO - 'NO_EM_RESTART': '1', 02:35:55 INFO - 'PAGER': '/bin/cat', 02:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:55 INFO - 'PWD': '/builds/slave/test', 02:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:55 INFO - 'SHELL': '/bin/bash', 02:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:35:55 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:55 INFO - 'USER': 'cltbld', 02:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:55 INFO - 'XPC_FLAGS': '0x0', 02:35:55 INFO - 'XPC_SERVICE_NAME': '0', 02:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:55 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 02:35:55 INFO - Cleaning up... 02:35:55 INFO - Return code: 0 02:35:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:55 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:35:55 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 02:35:55 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 02:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:55 INFO - 'HOME': '/Users/cltbld', 02:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:55 INFO - 'LOGNAME': 'cltbld', 02:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:55 INFO - 'MOZ_NO_REMOTE': '1', 02:35:55 INFO - 'NO_EM_RESTART': '1', 02:35:55 INFO - 'PAGER': '/bin/cat', 02:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:55 INFO - 'PWD': '/builds/slave/test', 02:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:55 INFO - 'SHELL': '/bin/bash', 02:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:35:55 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:55 INFO - 'USER': 'cltbld', 02:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:55 INFO - 'XPC_FLAGS': '0x0', 02:35:55 INFO - 'XPC_SERVICE_NAME': '0', 02:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:56 INFO - Downloading/unpacking psutil>=3.1.1 02:35:56 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 02:35:56 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 02:35:56 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 02:35:56 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 02:35:56 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 02:35:56 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 02:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:35:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:35:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:35:59 INFO - Installing collected packages: psutil 02:35:59 INFO - Running setup.py install for psutil 02:35:59 INFO - building 'psutil._psutil_osx' extension 02:35:59 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 02:36:00 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 02:36:00 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 02:36:00 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 02:36:00 INFO - building 'psutil._psutil_posix' extension 02:36:00 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 02:36:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:36:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:36:00 INFO - ^ 02:36:00 INFO - 1 warning generated. 02:36:00 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 02:36:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:00 INFO - Successfully installed psutil 02:36:00 INFO - Cleaning up... 02:36:00 INFO - Return code: 0 02:36:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:36: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')]} 02:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36: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')]} 02:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:00 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:00 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 02:36:00 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 02:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:00 INFO - 'HOME': '/Users/cltbld', 02:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:00 INFO - 'LOGNAME': 'cltbld', 02:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:00 INFO - 'MOZ_NO_REMOTE': '1', 02:36:00 INFO - 'NO_EM_RESTART': '1', 02:36:00 INFO - 'PAGER': '/bin/cat', 02:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:00 INFO - 'PWD': '/builds/slave/test', 02:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:00 INFO - 'SHELL': '/bin/bash', 02:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:00 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:00 INFO - 'USER': 'cltbld', 02:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:00 INFO - 'XPC_FLAGS': '0x0', 02:36:00 INFO - 'XPC_SERVICE_NAME': '0', 02:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:36:03 INFO - Installing collected packages: mozsystemmonitor 02:36:03 INFO - Running setup.py install for mozsystemmonitor 02:36:03 INFO - Successfully installed mozsystemmonitor 02:36:03 INFO - Cleaning up... 02:36:03 INFO - Return code: 0 02:36:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:03 INFO - 'HOME': '/Users/cltbld', 02:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:03 INFO - 'LOGNAME': 'cltbld', 02:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:03 INFO - 'MOZ_NO_REMOTE': '1', 02:36:03 INFO - 'NO_EM_RESTART': '1', 02:36:03 INFO - 'PAGER': '/bin/cat', 02:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:03 INFO - 'PWD': '/builds/slave/test', 02:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:03 INFO - 'SHELL': '/bin/bash', 02:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:03 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:03 INFO - 'USER': 'cltbld', 02:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:03 INFO - 'XPC_FLAGS': '0x0', 02:36:03 INFO - 'XPC_SERVICE_NAME': '0', 02:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:36:06 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 02:36:06 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 02:36:06 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 02:36:06 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 02:36:06 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 02:36:06 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 02:36:06 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:07 INFO - warning: no files found matching '*.txt' 02:36:07 INFO - no previously-included directories found matching 'build' 02:36:07 INFO - no previously-included directories found matching 'dist' 02:36:07 INFO - no previously-included directories found matching '.git*' 02:36:07 INFO - Installing collected packages: jsonschema, functools32 02:36:07 INFO - Running setup.py install for functools32 02:36:07 INFO - warning: no files found matching '*.txt' 02:36:07 INFO - no previously-included directories found matching 'build' 02:36:07 INFO - no previously-included directories found matching 'dist' 02:36:07 INFO - no previously-included directories found matching '.git*' 02:36:07 INFO - Successfully installed jsonschema functools32 02:36:07 INFO - Cleaning up... 02:36:07 INFO - Return code: 0 02:36:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:07 INFO - 'HOME': '/Users/cltbld', 02:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:07 INFO - 'LOGNAME': 'cltbld', 02:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:07 INFO - 'MOZ_NO_REMOTE': '1', 02:36:07 INFO - 'NO_EM_RESTART': '1', 02:36:07 INFO - 'PAGER': '/bin/cat', 02:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:07 INFO - 'PWD': '/builds/slave/test', 02:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:07 INFO - 'SHELL': '/bin/bash', 02:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:07 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:07 INFO - 'USER': 'cltbld', 02:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:07 INFO - 'XPC_FLAGS': '0x0', 02:36:07 INFO - 'XPC_SERVICE_NAME': '0', 02:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:36:07 INFO - Cleaning up... 02:36:07 INFO - Return code: 0 02:36:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:07 INFO - 'HOME': '/Users/cltbld', 02:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:07 INFO - 'LOGNAME': 'cltbld', 02:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:07 INFO - 'MOZ_NO_REMOTE': '1', 02:36:07 INFO - 'NO_EM_RESTART': '1', 02:36:07 INFO - 'PAGER': '/bin/cat', 02:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:07 INFO - 'PWD': '/builds/slave/test', 02:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:07 INFO - 'SHELL': '/bin/bash', 02:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:07 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:07 INFO - 'USER': 'cltbld', 02:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:07 INFO - 'XPC_FLAGS': '0x0', 02:36:07 INFO - 'XPC_SERVICE_NAME': '0', 02:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:07 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - Downloading docopt-0.6.1.tar.gz 02:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:11 INFO - Running setup.py install for blobuploader 02:36:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:11 INFO - Running setup.py install for requests 02:36:12 INFO - Running setup.py install for docopt 02:36:12 INFO - Successfully installed blobuploader requests docopt 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:12 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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:12 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 02:36:12 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 02:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:12 INFO - 'HOME': '/Users/cltbld', 02:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PAGER': '/bin/cat', 02:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:12 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - 'XPC_FLAGS': '0x0', 02:36:12 INFO - 'XPC_SERVICE_NAME': '0', 02:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-iWHFQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-bbZezs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-GVdiIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-VObFJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-k_dy5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-l_9J0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-2yh6ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-vR68NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-7NgxXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:13 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-upSWps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-YNk0Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-_roByn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-lLo1rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Bx_Tgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-wO1nGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-biGbWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:14 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-VygiSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:14 INFO - Running setup.py install for manifestparser 02:36:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:14 INFO - Running setup.py install for mozcrash 02:36:15 INFO - Running setup.py install for mozdebug 02:36:15 INFO - Running setup.py install for mozdevice 02:36:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Running setup.py install for mozfile 02:36:15 INFO - Running setup.py install for mozhttpd 02:36:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Running setup.py install for mozinfo 02:36:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Running setup.py install for mozInstall 02:36:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:15 INFO - Running setup.py install for mozleak 02:36:16 INFO - Running setup.py install for mozlog 02:36:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for moznetwork 02:36:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozprocess 02:36:16 INFO - Running setup.py install for mozprofile 02:36:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozrunner 02:36:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:16 INFO - Running setup.py install for mozscreenshot 02:36:17 INFO - Running setup.py install for moztest 02:36:17 INFO - Running setup.py install for mozversion 02:36:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:17 INFO - Cleaning up... 02:36:17 INFO - Return code: 0 02:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:17 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 02:36:17 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 02:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:17 INFO - 'HOME': '/Users/cltbld', 02:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:17 INFO - 'LOGNAME': 'cltbld', 02:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:17 INFO - 'MOZ_NO_REMOTE': '1', 02:36:17 INFO - 'NO_EM_RESTART': '1', 02:36:17 INFO - 'PAGER': '/bin/cat', 02:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:17 INFO - 'PWD': '/builds/slave/test', 02:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:17 INFO - 'SHELL': '/bin/bash', 02:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:17 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:17 INFO - 'USER': 'cltbld', 02:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:17 INFO - 'XPC_FLAGS': '0x0', 02:36:17 INFO - 'XPC_SERVICE_NAME': '0', 02:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:17 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-1n_5A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:17 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)) 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:17 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-5cLPpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:17 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)) 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:17 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-hKGwZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:17 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)) 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Y4DWDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-JFqnCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-4QQnaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-59co4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-UFiWAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-yQo7Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-RZll6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-KQf4NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:18 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-upFJxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:36:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:18 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-7qRKHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-MXQQ_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-y118Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-Fm9vug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:19 INFO - Running setup.py (path:/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/pip-1tQix9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:19 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)) 02:36:19 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)) 02:36:19 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)) 02:36:19 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)) 02:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:19 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 02:36:19 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 02:36:19 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 02:36:19 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 02:36:19 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 02:36:19 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 02:36:22 INFO - Downloading blessings-1.6.tar.gz 02:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:22 INFO - Installing collected packages: blessings 02:36:22 INFO - Running setup.py install for blessings 02:36:22 INFO - Successfully installed blessings 02:36:22 INFO - Cleaning up... 02:36:22 INFO - Return code: 0 02:36:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:22 INFO - Reading from file tmpfile_stdout 02:36:22 INFO - Current package versions: 02:36:22 INFO - blessings == 1.6 02:36:22 INFO - blobuploader == 1.2.4 02:36:22 INFO - docopt == 0.6.1 02:36:22 INFO - functools32 == 3.2.3-2 02:36:22 INFO - jsonschema == 2.5.1 02:36:22 INFO - manifestparser == 1.1 02:36:22 INFO - mozInstall == 1.12 02:36:22 INFO - mozcrash == 1.0 02:36:22 INFO - mozdebug == 0.1 02:36:22 INFO - mozdevice == 0.48 02:36:22 INFO - mozfile == 1.2 02:36:22 INFO - mozhttpd == 0.7 02:36:22 INFO - mozinfo == 0.9 02:36:22 INFO - mozleak == 0.1 02:36:22 INFO - mozlog == 3.4 02:36:22 INFO - moznetwork == 0.27 02:36:22 INFO - mozprocess == 0.23 02:36:22 INFO - mozprofile == 0.28 02:36:22 INFO - mozrunner == 6.13 02:36:22 INFO - mozscreenshot == 0.1 02:36:22 INFO - mozsystemmonitor == 0.3 02:36:22 INFO - moztest == 0.7 02:36:22 INFO - mozversion == 1.4 02:36:22 INFO - psutil == 3.1.1 02:36:22 INFO - requests == 1.2.3 02:36:22 INFO - wsgiref == 0.1.2 02:36:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:23 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 02:36:23 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 02:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:23 INFO - 'HOME': '/Users/cltbld', 02:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PAGER': '/bin/cat', 02:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:23 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - 'XPC_FLAGS': '0x0', 02:36:23 INFO - 'XPC_SERVICE_NAME': '0', 02:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:23 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')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:24 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 0x10a13e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc00cf23e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, '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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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 02:36:24 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 02:36:24 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 02:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:24 INFO - 'HOME': '/Users/cltbld', 02:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:24 INFO - 'LOGNAME': 'cltbld', 02:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:24 INFO - 'MOZ_NO_REMOTE': '1', 02:36:24 INFO - 'NO_EM_RESTART': '1', 02:36:24 INFO - 'PAGER': '/bin/cat', 02:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:24 INFO - 'PWD': '/builds/slave/test', 02:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:24 INFO - 'SHELL': '/bin/bash', 02:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:24 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:24 INFO - 'USER': 'cltbld', 02:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:24 INFO - 'XPC_FLAGS': '0x0', 02:36:24 INFO - 'XPC_SERVICE_NAME': '0', 02:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:36:24 INFO - Cleaning up... 02:36:24 INFO - Return code: 0 02:36:24 INFO - Running post-action listener: _resource_record_post_action 02:36:24 INFO - Running post-action listener: _start_resource_monitoring 02:36:24 INFO - Starting resource monitoring. 02:36:24 INFO - [mozharness: 2016-11-17 10:36:24.342178Z] Finished create-virtualenv step (success) 02:36:24 INFO - [mozharness: 2016-11-17 10:36:24.343159Z] Running install step. 02:36:24 INFO - Running pre-action listener: _resource_record_pre_action 02:36:24 INFO - Running main action method: install 02:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:24 INFO - Reading from file tmpfile_stdout 02:36:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:24 INFO - Reading from file tmpfile_stdout 02:36:24 INFO - Output received: 02:36:24 INFO - Usage: mozinstall [options] installer 02:36:24 INFO - Options: 02:36:24 INFO - -h, --help show this help message and exit 02:36:24 INFO - -d DEST, --destination=DEST 02:36:24 INFO - Directory to install application into. [default: 02:36:24 INFO - "/builds/slave/test"] 02:36:24 INFO - --app=APP Application being installed. [default: firefox] 02:36:24 INFO - mkdir: /builds/slave/test/build/application 02:36:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:36:56 INFO - Reading from file tmpfile_stdout 02:36:56 INFO - Output received: 02:36:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:36:56 INFO - Running post-action listener: _resource_record_post_action 02:36:56 INFO - [mozharness: 2016-11-17 10:36:56.686167Z] Finished install step (success) 02:36:56 INFO - [mozharness: 2016-11-17 10:36:56.686326Z] Running run-tests step. 02:36:56 INFO - Running pre-action listener: _resource_record_pre_action 02:36:56 INFO - Running main action method: run_tests 02:36:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:36:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:36:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:36:56 INFO - 2016-11-17 02:36:56.700 screenresolution[1625:7263] starting screenresolution argv=screenresolution get 02:36:56 INFO - 2016-11-17 02:36:56.703 screenresolution[1625:7263] Display 0: 1600x1200x32@60 02:36:56 INFO - 2016-11-17 02:36:56.709 screenresolution[1626:7265] starting screenresolution argv=screenresolution list 02:36:56 INFO - Available Modes on Display 0 02:36:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:36:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:36:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:36:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:36:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:36:56 INFO - Intel Iris: 02:36:56 INFO - Chipset Model: Intel Iris 02:36:56 INFO - Type: GPU 02:36:56 INFO - Bus: Built-In 02:36:56 INFO - VRAM (Dynamic, Max): 1536 MB 02:36:56 INFO - Vendor: Intel (0x8086) 02:36:56 INFO - Device ID: 0x0a2e 02:36:56 INFO - Revision ID: 0x0009 02:36:56 INFO - Displays: 02:36:56 INFO - Display: 02:36:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:36:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:36:56 INFO - Display Serial Number: 1600x1200 60 02:36:56 INFO - Main Display: Yes 02:36:56 INFO - Mirror: Off 02:36:56 INFO - Online: Yes 02:36:56 INFO - Rotation: Supported 02:36:56 INFO - Return code: 0 02:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:56 INFO - Python 2.7.3 02:36:56 INFO - Return code: 0 02:36:56 INFO - grabbing minidump binary from tooltool 02:36: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')]} 02:36:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f52d30>, '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 0x109db8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f4ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:36:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:36:56 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 02:36:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:57 INFO - Return code: 0 02:36:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:36:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:36:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--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 02:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0364 --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 02:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uZUL6V7tpi/Render', 02:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:57 INFO - 'HOME': '/Users/cltbld', 02:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:57 INFO - 'LOGNAME': 'cltbld', 02:36:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:57 INFO - 'MOZ_NO_REMOTE': '1', 02:36:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:57 INFO - 'NO_EM_RESTART': '1', 02:36:57 INFO - 'PAGER': '/bin/cat', 02:36:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:57 INFO - 'PWD': '/builds/slave/test', 02:36:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:57 INFO - 'SHELL': '/bin/bash', 02:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9QsJjYPO9c/Listeners', 02:36:57 INFO - 'TMPDIR': '/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/', 02:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:57 INFO - 'USER': 'cltbld', 02:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:57 INFO - 'XPC_FLAGS': '0x0', 02:36:57 INFO - 'XPC_SERVICE_NAME': '0', 02:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0364', '--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 02:36:57 INFO - mozversion application_buildid: 20161117004016 02:36:57 INFO - mozversion application_changeset: d86e4e3d92b082d1e86160ac182f8c73cd80597a 02:36:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:36:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:57 INFO - mozversion application_name: Firefox 02:36:57 INFO - mozversion application_remotingname: firefox-dev 02:36:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:36:57 INFO - mozversion application_vendor: Mozilla 02:36:57 INFO - mozversion application_version: 52.0a2 02:36:57 INFO - mozversion platform_buildid: 20161117004016 02:36:57 INFO - mozversion platform_changeset: d86e4e3d92b082d1e86160ac182f8c73cd80597a 02:36:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:36:57 INFO - mozversion platform_version: 52.0a2 02:36:57 INFO - using testdate: 1479379017 02:36:57 INFO - actual date: 1479379017 02:36:57 INFO - starting webserver on 'localhost:49241' 02:36:57 INFO - SUITE-START | Running 2 tests 02:36:57 INFO - TEST-START | dromaeo_css 02:36:57 INFO - operating with platform_type : mac_ 02:36:57 INFO - Initialising browser for dromaeo_css test... 02:36:57 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmptUvaus/profile http://localhost:49241/getInfo.html) 02:36:59 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 02:37:00 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 02:37:00 INFO - PROCESS | 1636 | colorDepth:24 02:37:00 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 02:37:00 INFO - PROCESS | 1636 | __metrics 02:37:00 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 02:37:01 INFO - TEST-INFO | 1636: exit 0 02:37:01 INFO - Browser initialized. 02:37:01 INFO - Running cycle 1/1 for dromaeo_css test... 02:37:01 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmptUvaus/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:13 INFO - PROCESS | 1641 | RSS: Main: 223895552 02:37:13 INFO - PROCESS | 1641 | 02:38:02 INFO - PROCESS | 1641 | 1479379082904 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:40:16 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:40:18 INFO - PROCESS | 1641 | RSS: Main: 233934848 02:40:18 INFO - PROCESS | 1641 | 02:43:20 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 02:43:21 INFO - PROCESS | 1641 | RSS: Main: 244817920 02:43:21 INFO - PROCESS | 1641 | 02:46:23 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 02:46:23 INFO - PROCESS | 1641 | RSS: Main: 247812096 02:46:23 INFO - PROCESS | 1641 | 02:49:25 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 02:49:26 INFO - PROCESS | 1641 | RSS: Main: 247717888 02:49:26 INFO - PROCESS | 1641 | 02:52:29 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 02:52:29 INFO - PROCESS | 1641 | RSS: Main: 254550016 02:52:29 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 02:55:32 INFO - PROCESS | 1641 | RSS: Main: 256069632 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | __start_tp_report 02:55:32 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 02:55:32 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 02:55:32 INFO - PROCESS | 1641 | |i|pagename|runs| 02:55:32 INFO - PROCESS | 1641 | |0;dojo.html;2921.714445643917;3215.6945090216436;3265.4448743713565;3365.7475689323305;3413.4367829308167;5368.221607866857;5700.429957004298;5706.400827913067;5760.7695692172265;5768.105943578752;4335.65314774818;5696.629719068268;5769.451902069297;5821.621594596349;5845.123231515275;4289.721168124078;5217.86955326118;5281.419043905186;5283.8150664726745;5322.813701520428;4947.183714687072;5307.495787900143;5325.3077099976945;5339.385970613371;5342.385625653042;5155.355580552431;5175.922361164586;5331.067063263933;5350.143976963686;5392.379876314235;5239.816606418776;5248.134057880445;5266.34170728659;5270.077736396153;5278.894422111574;5132.332796736438;5158.664686795346;5203.60972927032;5238.240455134022;5341.359036915556;4797.920467894731;5170.482951704837;5823.126531020339;5843.240378750777;5861.6189947653265;5983.461488466059;6138.508919286446;6156;6194.876102477971;6205.6897155142515;6122.632642041492;6155.107509411155;6159.922013647639;6218.067289906505;6229.7508099676415;4782.832600858953;5809.2738407699035;5828.766849326064;5915.231019967419;5985.700714964234;6186.81439556814;6273.37266273369;6275.905861412082;6307.747690092345;6310.7791227306825;6146.846328841725;6151.138840562325;6157.9384206157365;6169;6182.979808331665;6121.849304493819;6160.1375807387;6190.350013248634;6215.564910456224;6224.688765561704;6138.570300078952;6189.442950134509;6199.876002479925;6210.441060304594;6225.750969961151;6064.848378790565;6105.542084343603;6171.9691401542705;6175.320714721377;6205.720742566505;4863.586595139453;4914.017196560702;4929.580985616191;4932.482089380635;4938.802447902043;4353.238183317907;4403.3394990751;4404.009097952935;4427.313766366218;4446.421965144576;5872.941270587325;5905.173275741399;5926.4369884861735;5948.405159484017;5949.940500595025;4312.978435107867;6108.633481991006;6154.261488621304;6154.969225153935;6178.536609754196;4808.134535783523;5884.529237660977;5893.499052580579;5968.761249550056;6036.426539478743;5316.76074576645;5447.618666693373;5456.91814622781;5488.17677348401;5506.587005974568;6175.073738939105;6271.278802937721;6327.651979141191;6391.8721625566295;6431.163948686641;5821.388754180919;6132.508481341157;6197.194364732556;6271.905921411091;6275.466585340298;5733.881893030819;6388.616682999035;6411.647359395278;6431.1317972073175;6432.549721519636;4986.775595098156;6170.3212646607935;6177.62934223948;6185.907211391923;6191.783287584913;6072.696365181811;6075.36208698098;6115.0273862886115;6125.052321062068;6173.074038894202;4250.681198910032;4616.238320677185;6066.15073889647;6116.4495195430845;6164.907526387018;4935.481774413778;6138;6158.137860699595;6180.783672571439;6200.627962322275;5831.096180092092;5924.11138329254;5951.613145145551;6064.968955277702;6088.726007329592;6089.969550152221;6102.694865256808;6123.387661233841;6127.754889804358;6134.191681013941;6001.279846418458;6023;6024.789132380346;6027.909581356195;6030.216071910623 02:55:32 INFO - PROCESS | 1641 | |1;ext.html;444.89322562584977;476.38308390634126;522.3209827224608;526.4761562245563;546.4017748086845;38231.617683823155;39509.20981580367;39663.206735865264;39697.00757481065;39763.40354894671;40519;41083;41090.79454602723;41155.38266925998;41177.794111029405;9158.58786354614;9246.260299176083;9325.906740932605;9339.252859771203;9363.859542106873;9163.633454661838;9186.081391860827;9302.767430814216;9358.438493690366;9371.062893710608;9182.72451826443;9337.953310233474;9374.156325930664;9383.5308234588;9392.483413412294;9297;9379.577918993662;9380.390274632127;9384.108509691569;9420.152186303198;9045.095490450967;9131.543422828832;9134.725958221265;9217.953910230406;9229.169374756304;38639.61360386416;38982.83051508459;39042.41436378456;39125;39161.60838391608;3278.1149089745873;3302.5046243063493;3320.5849268841393;3346.4478361070396;3403.1662242750435;29590;29958.55062174069;29975;30241.243968900733;30478;3144.7326977206967;3196.9200769980703;3200.519922011694;3209.2297848516187;3230.596175478065;497377;504919;505997;506992;507109;56427;56459;56765;56933.715331423904;57008.42991570031;59319.51701207418;59516.70241648851;59562;59570.40429595735;59587.40412595905;15685.686286274438;15690;15873;15901.125438100784;15904.12527310986;11877;12384.256944583354;12387.504499820086;12392.62822115338;12452.377381130907;15061;15279.541613751606;15500.30248638814;15561.766573501407;15656.843431565767;3173.793703409271;3270.280538281574;3306.140403495109;4949.356583644103;6359.745610175633;799.7800604833717;833.4957350802798;972.2125078686287;1003.3277703938379;1025.7589466475372;27735;29011.854940725585;29356.706432935825;29938.55092173619;30033;1041.510490069666;1054.9525271362807;1077.8221593437152;1104.718296834302;1110.3171549497163;12624.684382890318;12829.011503217016;15629.218539073001;15763.921180394025;16039.278232479566;610761;611661.9416902887;611674;615521;616215;45141;54397;54404;54900;54981.450185498434;1291.593148158327;1306.660268330222;1345.710672205461;1346.4748747988292;1346.7643162446532;29110.27224319409;29604.555931661474;29796.553051704675;30269.69730302669;30356.785728571493;47662.523374767195;52054.219186711474;53422.73288633532;53647.731761342504;56642.433575663716;609125;615779;617293;620309;620825.8958705177;40437.79781101076;41013.1797364057;41362.58637413587;41392.79303603463;41684;43767.12465750731;44701;44800;45223.547764521936;45381.54618453773;37004.81497592495;37032;37710.434343485416;38850;39035.21929561449;37518.06204844901;37829.81085094557;38608.80695596504;38679.80660096682;39000.829975100794;36372;36712.63287367092;36718;36772.964400067875;36832.3209829904;25774;30441;32146.678533215305;32484.67515324911;34213;22894.084236630348;25271.620925685762;25302;25314.367140821625;25807.225783226535 02:55:32 INFO - PROCESS | 1641 | |2;jquery.html;367.66175118890635;374.29819089207734;379.27747640744394;385.7878167008146;398.8962869653891;18209.99845008524;19841.40475785725;20058.297959571417;20178;20303.289384871532;19803.702944455843;20004.399868003948;20107.195712171495;20340;20650.173993040262;5505.752241149138;5805.303363596375;5932.644041357511;6064.423879731418;6127.81616551502;5976.103584462322;6105.145279660851;6105.786297479589;6115.571909966304;6116.235470566179;5731.742071606787;5970.373110823366;6006.369331220225;6006.909896351558;6068.878622427571;5690.857728556778;5937.554683398741;5978.192943952554;5999.880002399949;6016.398360163992;5114.923276150861;5170.6122040847085;5171.250168725552;5176.06830770465;5176.974115129438;24404.02383904642;24449.633255501183;24500.529968201965;24759.752402475926;25271.747282527307;2303.2284184798114;2367.0531787285054;2454.9877250613813;2497.2882728422314;2943.7644988400875;14302.785458218135;15267.160306183156;15484.148371839545;15573.987690800062;15837.762433563506;1823.2798044772242;1860.8555738220896;1896.1656870976726;1896.6396384687002;1943.2518480385013;109120.90879091187;111779.44110279478;117076;118428.40785796016;119466;10527.94736026315;10562.788744225072;10743.677689669323;11267.887321126847;11476.54093836254;13468.932655336857;13476.39356228972;13658.180509169282;13665.931670341584;13855.722885542233;8030.879536806952;8452.66189352419;8536.786580335542;8680.218780309677;8700.260477859452;8147.185281471805;8325.708600199085;8362.749117526484;8367.874481882776;8768.956155219183;5510.669359838423;6494.9350506495275;6706.792777300036;6722.630255336004;6744.258131605519;1573.299881552721;1828.6799810033192;1859.7675290588677;1868.3367404571454;1869.1121717184228;753.8605358008786;907.981840363189;939.7227817793768;947.6872632031414;1012.7468132966758;20845.478863028544;21419.892900535397;21633;21735;21795.019224134634;973.3916302311055;977.3158788847835;982.4841957971979;985.2905907746411;1044.5717255925185;11332.71668208285;11552.711182220344;11558.306501609763;11577.6526704199;11618;621262.8936855287;628033;632784;633579;641603;82856.58571707102;107384.46307768411;113397;118407.40796295964;118780.21829672562;817.8691409374591;854.4446110028531;957.167264479907;987.9506024698736;1009.1422291052693;18675.813241867407;18957.71563426522;19243.03784810782;19323;19355.8064419354;50683;51333;51524.742376287875;51814.70463238449;52640.7367963173;67117.3288267111;75281;77184;77767.61116194609;83850;7541.773746787605;7947.284744373034;8017.398695097774;8140.087079536423;8174.632141553526;11301.830472542753;12588.055895807667;12598.937005314914;12603.621891343275;12788.616341509769;10388.272820902464;10823.512941917475;10852.294600850919;10886.346819190874;11142.932829517005;10836.891631083903;10881.183911206534;10886.23796334249;10899;10908.454577271263;11054;11089.27919685218;11300.604478843201;11444.484998175269;11560.595379161688;7939.84120317602;8087.433879628369;8117.756467305991;8143;8256.628451719567;9560.330776845554;10540.736481588021;11033.779324413626;11056.502457389275;11161.72095697614 02:55:32 INFO - PROCESS | 1641 | |3;mootools.html;1433.8637829406207;1471.7931296337001;1668.9916550417247;1777.3157334426242;1812.6193499365124;7344.596047217401;7628.084629844427;8092.393070519713;8561.657533698652;8571.142885711433;7991.720289789859;8295.1290114538;8313.50118992861;8414.158584141584;8428.452150610206;2319.8376113672093;2358.6108292131776;2358.6579945907833;2359.752226016269;2367.4554852383962;2351.247600767755;2370.0519792083132;2401.435662619283;2402.531506356261;2403.507281007398;2336.0772494864605;2342.8360014798973;2359.6224604063354;2363;2363.2201373546773;2296.3799774060994;2299.3906614747107;2312.225404489498;2324.732655744586;2332.288651961151;2344.824138189643;2357.587422201108;2377.702787151606;2381.89281482332;2383.8569685818907;8387.287080598157;8444.493330400133;8504.064552899237;8519;8529.74410767678;5150.124478838569;5316.760745766411;5328.973355133199;5329.573634109262;5332.360116786011;3453.4474484082425;3508.5965114011706;3512.824358782076;3565.108722819295;3588.551431071116;1014.3052009373529;1029.1355261580234;1065.0893486069376;1067.2795862792661;1071.6463567022943;10912.563497460093;10963.397013164273;11054.889451105466;11089;11093.3898635575;4497.8425755098415;4658.813647454132;4756.072565849626;4757.381540399726;4772.76136193189;9418.811623767486;9499.525023748924;9506.809863802686;9511.619535218651;9520.476373799369;4299.54854740254;5192.9740351298005;5236.711980841014;5248.501392367719;5268.683878967274;4321.330193819963;4331.696781225284;4628.930566041512;4803.135435621622;4833.975830120827;3064.6169228846393;3294.341131773655;3390.813505257185;3678.2459595782802;3953.0710283083454;1035.1625864091297;1066.8637900635797;1228.729679470515;1278.2586100061942;1288.2463758701265;775.1279810213509;791.7941335252875;852.4416507187802;911.7811725185908;922.6724512797995;5534.944650553523;5712.914306285409;5810.273715785527;5851.414858514199;5863.296404431496;802.8033131882726;914.835329640671;926.4904302633524;934.1919239857474;941.8069295794346;3823.502944617182;3841.7118716096406;3847.6537111659527;3884.320243957296;3900.531936167621;7728.343090837229;10080.546375413123;10083.394996300245;10259.640912568024;10291.33106348085;10200.4389758564;10206.13247873939;10208.285420020677;10231.925647807022;10289.125424338865;7810.6875724971505;7998.160193179749;8017.959910200411;8020.197980201933;8042.356611471068;5403.189521571796;5575.275214222125;5612.719364031864;5724.656520608777;5868.823935281948;9322.254219662274;9378.95310523443;9463.337566370288;9476.099770521789;9493.66772162971;9361.812763744823;9402.2948278878;9534.332596718163;9658.71023869285;9730.36752611078;7096.822579435349;7174.246704095995;7227.096612923385;7246.275372462712;7279.890801637874;7784.883226751716;7822.256885595859;7858.960705196438;7889.881651775343;7905.169957154416;7041.859162816818;7095.886069681165;7158.928410716035;7281.199068102399;7291.08861392326;6951.235364110045;7044.401225895651;7052.118485189351;7133.678984445816;7195.568265904062;6718.563293385914;6727;6799.5920244785475;6801.591904485746;6801.829954251183;4812.542808433193;4837.975810120927;4874.2201247800185;4894.510548945077;4911.435184953776;4668.206404911241;4731.976340118277;4802.207635740064;4809.158397280392;4820.108279968077 02:55:32 INFO - PROCESS | 1641 | |4;prototype.html;302.33788004270644;307.4880324260107;313.28883434603443;314.2207325831935;316.82732910563743;4871.7333493291735;5239.79484718515;5246.658967167132;5557.944420555793;5593.105103183487;4238.364245363197;4378.5840345167235;4975.154223781957;5343.984642917843;5384.757685904134;3063.5251536011842;3446.5864096308414;4008.4388185653884;4156.833726650931;4195.370694395834;3867.57456679765;4177.289860723684;4181.163767246548;4194.615776793651;4213.262679031172;3630.9273814523694;4062.8171732272117;4076.429299898017;4084.36692312692;4104.8563300284495;3391.4404123319623;3416.4533674612067;3499.3001399720156;3573.5175751273764;4067.2882245607198;3072.6159230096237;3565.8751943682105;3569.9107522311892;3579.570451545805;3589.971666008723;4171.6036976487185;4634.907301853944;4798.856034318976;4971.801127954877;5158.329417175781;3942.2601292102;3976.403539469074;4076.9388459173138;4401.92152922536;4714.528547145293;5743.10323305455;5759.452851979056;5766.654000759968;5768.942310576883;5784.797532086399;3126.6873312668777;3767;3889.202713443737;3939.0546268895546;3947.4276229946786;5858.443447872488;6003.579749417542;6038.456538911475;6049.243844519435;6059.697015149269;3288.588926384202;3313.93372132556;3584.982075089608;3950.308695978192;3954.7429417087797;3363.6972672459106;3770.7737535747942;3989;4024.7182697210915;4053.5946405359227;3844.9426407738097;4081.6530594899173;4610.985583171697;4655.162070827284;4673.182193116191;5076.959223359203;5127.769250383742;5683.687397193194;5795.7391917362975;5833.270841144857;1068.5992752717732;1072.7318170457386;1095.6932059023486;1104.1994553948484;1123.5393488669606;873.3799002708022;896.2605850173633;908.1281969309537;938.4510061613896;945.9925179683615;4703.8484215575645;4788.924987149332;4908.545727136432;5192.584593232532;5225.399079105951;5446.673199608036;5601.243832082698;5712.885742285131;5729.1119876419225;5736.852629474122;4207.663386929038;4491.955080449219;4679.67242293043;4909.680870743462;5164.764892787953;2441.593976402908;2779.2496026072845;2944.219781757836;2957.896473623413;2974.3605124897817;4979.57673597741;5432.972835135799;5817.632856278771;5828.358880523139;5893.764249430061;5753;5794.159846822187;5826.271716035496;5833.7374818133285;5850.707464626752;4815.951840481621;5742.59801813869;5782.6819524925695;5803.709814509342;5866.090755932837;4388.692791504564;4808.663393562417;5014.08901057176;5255.553277971415;5724.513416359656;4604.6186144155945;5158.252053452304;5362.249285100011;5578.103444828777;5613.073842815889;5019.117830813445;5121.8463446096675;5329.427818793542;5683.062294721325;5847.766089356548;3159.605049368829;3327.667233276653;3451.706604938508;3964.759910650473;3964.821583028713;5206.921896171636;5273.789048438173;6086.452219300284;6114.571979961538;6116;4599.609033232213;4820.228763397839;5410.3507579090765;5655.519280861173;5692.3169219692245;5597.236870385816;5798.723721097566;5813.505852002627;5824.767009319749;5832.300123985149;5214.791408343775;5299;5556.305461817273;5673.77304907799;5690.345610254708;5832.795852145155;5856.603170161381;5909.143174239625;5922.585419020627;5964.9105263420215;4247.745135291769;4708;4977;5290.518654776669;5596.772744066217 02:55:32 INFO - PROCESS | 1641 | |5;yui.html;669.4042302350908;683.6889215406991;700.719712115154;747.0960138232738;790.758818560339;13990.160590364585;14600.41598336068;14629.78055329171;14645.487407940724;14678.77981830272;11863.822042669346;13129.949604031679;13261.801072983888;13880.791788123186;14746.483873064444;793.8729803231485;801.527099011583;820.3437250199817;836.9874451883227;842.1115722912325;829.5561874397199;831.7837362285788;831.8086840026798;831.995840020799;836.8368168207202;863.2532859076916;866;869.8651708985086;874.5802015032788;880.4541184465609;834.5326617094447;847.2205570874779;863.1799790199336;867.895852497698;871.8866547348836;623.1027320658283;640.1134428816076;641.0096401060326;646.7930262316061;647.5014239035916;13840.30798460083;13952.860471395257;13968.790468142986;13970.720585588333;13975.720485590231;13464.798028029587;13747.656308592264;13821.723565528633;13877.514286999907;13965.441382344694;9300.581473833694;11215.15886308522;11295;11395.487203075882;11511.827322590168;3425.246445781924;3523.594786599548;3569.8215089245696;3614.3313487004725;3666.24841907411;89370.5531472345;91929.54035229849;93261.53369233178;93400;94238.52880735553;10027.79944401108;10091;10260.076593106507;10349;10472.68581942543;18815.90592047031;19513;19694.31069912546;19724.605507889763;19758.70361944572;7319.268073192638;7398.593077380688;7412.407007439392;7475.5888426136;7549.396048316122;4131.462909821764;4233.174530966494;4258.1057977825;4264.0832221072615;4270;3356.3622911646708;3451.4132597458492;3458.170039190576;3475.991962330946;3503.5445392098864;595.4462350014528;633.6989929783316;644.7421031587403;649.9967500162469;658.1575583253443;584.5820238529471;636.2555809702659;644.7002144003061;649.7108786590017;666.8732940741244;8582.785430364165;8875.600597973107;9008.369414141078;9051.864222036675;9178.128077832594;458.76373667561234;539.5683453237394;555.7443575955106;632.9840605827673;671.7111641993989;3676.540432445944;4021.6380525752825;4064.227796718614;4521.932171017437;4545.090981803586;90244;109476;110032;110044.4497777506;111827;73027.63486182535;80958.19041809624;82493.17506824975;96434;96914.0308596919;58767.706161468916;64215.35784642187;66019.33980660228;82765.58617206996;84987.15012849915;9307.534623268673;9781.902180978099;9912.900870991198;9928.503574821374;9930.25523085757;48450;48727.0254594899;49108;55684;55843.88312233651;57700.55748606318;71799.28200718135;72550.28423152478;77745;77953.61023194848;12112.333821639895;12123.878761212274;12421.875781242434;12465.376731163587;12586.521128584134;13757.243351615758;13786.586402407944;13812.24032678172;14125.858741412454;14172.433102675777;10659.680209593724;12506;12838.29389383593;13061.21632702041;13184;9933.205343572641;11665;12618.684532886751;12635.494580217057;12958;12284.692882678004;12753.362331883183;12931.870681293067;13093.803592946304;13229;10964.506597202986;11658.417079146178;11696.70758231051;11842.407879605813;11934.462949167482;9350.625974960925;11491.48288327044;11513.88486115128;11519.654410367702;11597.942010289895 02:55:32 INFO - PROCESS | 1641 | __end_tp_report 02:55:32 INFO - PROCESS | 1641 | __start_cc_report 02:55:32 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,372 02:55:32 INFO - PROCESS | 1641 | __end_cc_report 02:55:32 INFO - PROCESS | 1641 | __startTimestamp1479380132574__endTimestamp 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | ------- Summary: start ------- 02:55:32 INFO - PROCESS | 1641 | Number of tests: 6 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5677.65 Median:5968.76 stddev:698.62 (11.7%) stddev-sans-first:666.47 02:55:32 INFO - PROCESS | 1641 | Values: 2921.7 3215.7 3265.4 3365.7 3413.4 5368.2 5700.4 5706.4 5760.8 5768.1 4335.7 5696.6 5769.5 5821.6 5845.1 4289.7 5217.9 5281.4 5283.8 5322.8 4947.2 5307.5 5325.3 5339.4 5342.4 5155.4 5175.9 5331.1 5350.1 5392.4 5239.8 5248.1 5266.3 5270.1 5278.9 5132.3 5158.7 5203.6 5238.2 5341.4 4797.9 5170.5 5823.1 5843.2 5861.6 5983.5 6138.5 6156.0 6194.9 6205.7 6122.6 6155.1 6159.9 6218.1 6229.8 4782.8 5809.3 5828.8 5915.2 5985.7 6186.8 6273.4 6275.9 6307.7 6310.8 6146.8 6151.1 6157.9 6169.0 6183.0 6121.8 6160.1 6190.4 6215.6 6224.7 6138.6 6189.4 6199.9 6210.4 6225.8 6064.8 6105.5 6172.0 6175.3 6205.7 4863.6 4914.0 4929.6 4932.5 4938.8 4353.2 4403.3 4404.0 4427.3 4446.4 5872.9 5905.2 5926.4 5948.4 5949.9 4313.0 6108.6 6154.3 6155.0 6178.5 4808.1 5884.5 5893.5 5968.8 6036.4 5316.8 5447.6 5456.9 5488.2 5506.6 6175.1 6271.3 6327.7 6391.9 6431.2 5821.4 6132.5 6197.2 6271.9 6275.5 5733.9 6388.6 6411.6 6431.1 6432.5 4986.8 6170.3 6177.6 6185.9 6191.8 6072.7 6075.4 6115.0 6125.1 6173.1 4250.7 4616.2 6066.2 6116.4 6164.9 4935.5 6138.0 6158.1 6180.8 6200.6 5831.1 5924.1 5951.6 6065.0 6088.7 6090.0 6102.7 6123.4 6127.8 6134.2 6001.3 6023.0 6024.8 6027.9 6030.2 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:70510.10 Median:39335.41 stddev:155209.60 (394.6%) stddev-sans-first:155555.85 02:55:32 INFO - PROCESS | 1641 | Values: 444.9 476.4 522.3 526.5 546.4 38231.6 39509.2 39663.2 39697.0 39763.4 40519.0 41083.0 41090.8 41155.4 41177.8 9158.6 9246.3 9325.9 9339.3 9363.9 9163.6 9186.1 9302.8 9358.4 9371.1 9182.7 9338.0 9374.2 9383.5 9392.5 9297.0 9379.6 9380.4 9384.1 9420.2 9045.1 9131.5 9134.7 9218.0 9229.2 38639.6 38982.8 39042.4 39125.0 39161.6 3278.1 3302.5 3320.6 3346.4 3403.2 29590.0 29958.6 29975.0 30241.2 30478.0 3144.7 3196.9 3200.5 3209.2 3230.6 497377.0 504919.0 505997.0 506992.0 507109.0 56427.0 56459.0 56765.0 56933.7 57008.4 59319.5 59516.7 59562.0 59570.4 59587.4 15685.7 15690.0 15873.0 15901.1 15904.1 11877.0 12384.3 12387.5 12392.6 12452.4 15061.0 15279.5 15500.3 15561.8 15656.8 3173.8 3270.3 3306.1 4949.4 6359.7 799.8 833.5 972.2 1003.3 1025.8 27735.0 29011.9 29356.7 29938.6 30033.0 1041.5 1055.0 1077.8 1104.7 1110.3 12624.7 12829.0 15629.2 15763.9 16039.3 610761.0 611661.9 611674.0 615521.0 616215.0 45141.0 54397.0 54404.0 54900.0 54981.5 1291.6 1306.7 1345.7 1346.5 1346.8 29110.3 29604.6 29796.6 30269.7 30356.8 47662.5 52054.2 53422.7 53647.7 56642.4 609125.0 615779.0 617293.0 620309.0 620825.9 40437.8 41013.2 41362.6 41392.8 41684.0 43767.1 44701.0 44800.0 45223.5 45381.5 37004.8 37032.0 37710.4 38850.0 39035.2 37518.1 37829.8 38608.8 38679.8 39000.8 36372.0 36712.6 36718.0 36773.0 36832.3 25774.0 30441.0 32146.7 32484.7 34213.0 22894.1 25271.6 25302.0 25314.4 25807.2 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:35361.40 Median:13477.76 stddev:104568.58 (775.9%) stddev-sans-first:104828.91 02:55:32 INFO - PROCESS | 1641 | Values: 367.7 374.3 379.3 385.8 398.9 18210.0 19841.4 20058.3 20178.0 20303.3 19803.7 20004.4 20107.2 20340.0 20650.2 5505.8 5805.3 5932.6 6064.4 6127.8 5976.1 6105.1 6105.8 6115.6 6116.2 5731.7 5970.4 6006.4 6006.9 6068.9 5690.9 5937.6 5978.2 5999.9 6016.4 5114.9 5170.6 5171.3 5176.1 5177.0 24404.0 24449.6 24500.5 24759.8 25271.7 2303.2 2367.1 2455.0 2497.3 2943.8 14302.8 15267.2 15484.1 15574.0 15837.8 1823.3 1860.9 1896.2 1896.6 1943.3 109120.9 111779.4 117076.0 118428.4 119466.0 10527.9 10562.8 10743.7 11267.9 11476.5 13468.9 13476.4 13658.2 13665.9 13855.7 8030.9 8452.7 8536.8 8680.2 8700.3 8147.2 8325.7 8362.7 8367.9 8769.0 5510.7 6494.9 6706.8 6722.6 6744.3 1573.3 1828.7 1859.8 1868.3 1869.1 753.9 908.0 939.7 947.7 1012.7 20845.5 21419.9 21633.0 21735.0 21795.0 973.4 977.3 982.5 985.3 1044.6 11332.7 11552.7 11558.3 11577.7 11618.0 621262.9 628033.0 632784.0 633579.0 641603.0 82856.6 107384.5 113397.0 118407.4 118780.2 817.9 854.4 957.2 988.0 1009.1 18675.8 18957.7 19243.0 19323.0 19355.8 50683.0 51333.0 51524.7 51814.7 52640.7 67117.3 75281.0 77184.0 77767.6 83850.0 7541.8 7947.3 8017.4 8140.1 8174.6 11301.8 12588.1 12598.9 12603.6 12788.6 10388.3 10823.5 10852.3 10886.3 11142.9 10836.9 10881.2 10886.2 10899.0 10908.5 11054.0 11089.3 11300.6 11444.5 11560.6 7939.8 8087.4 8117.8 8143.0 8256.6 9560.3 10540.7 11033.8 11056.5 11161.7 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5476.18 Median:5171.55 stddev:3005.42 (58.1%) stddev-sans-first:2998.50 02:55:32 INFO - PROCESS | 1641 | Values: 1433.9 1471.8 1669.0 1777.3 1812.6 7344.6 7628.1 8092.4 8561.7 8571.1 7991.7 8295.1 8313.5 8414.2 8428.5 2319.8 2358.6 2358.7 2359.8 2367.5 2351.2 2370.1 2401.4 2402.5 2403.5 2336.1 2342.8 2359.6 2363.0 2363.2 2296.4 2299.4 2312.2 2324.7 2332.3 2344.8 2357.6 2377.7 2381.9 2383.9 8387.3 8444.5 8504.1 8519.0 8529.7 5150.1 5316.8 5329.0 5329.6 5332.4 3453.4 3508.6 3512.8 3565.1 3588.6 1014.3 1029.1 1065.1 1067.3 1071.6 10912.6 10963.4 11054.9 11089.0 11093.4 4497.8 4658.8 4756.1 4757.4 4772.8 9418.8 9499.5 9506.8 9511.6 9520.5 4299.5 5193.0 5236.7 5248.5 5268.7 4321.3 4331.7 4628.9 4803.1 4834.0 3064.6 3294.3 3390.8 3678.2 3953.1 1035.2 1066.9 1228.7 1278.3 1288.2 775.1 791.8 852.4 911.8 922.7 5534.9 5712.9 5810.3 5851.4 5863.3 802.8 914.8 926.5 934.2 941.8 3823.5 3841.7 3847.7 3884.3 3900.5 7728.3 10080.5 10083.4 10259.6 10291.3 10200.4 10206.1 10208.3 10231.9 10289.1 7810.7 7998.2 8018.0 8020.2 8042.4 5403.2 5575.3 5612.7 5724.7 5868.8 9322.3 9379.0 9463.3 9476.1 9493.7 9361.8 9402.3 9534.3 9658.7 9730.4 7096.8 7174.2 7227.1 7246.3 7279.9 7784.9 7822.3 7859.0 7889.9 7905.2 7041.9 7095.9 7158.9 7281.2 7291.1 6951.2 7044.4 7052.1 7133.7 7195.6 6718.6 6727.0 6799.6 6801.6 6801.8 4812.5 4838.0 4874.2 4894.5 4911.4 4668.2 4732.0 4802.2 4809.2 4820.1 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4465.59 Median:4940.74 stddev:1431.14 (29.0%) stddev-sans-first:1400.63 02:55:32 INFO - PROCESS | 1641 | Values: 302.3 307.5 313.3 314.2 316.8 4871.7 5239.8 5246.7 5557.9 5593.1 4238.4 4378.6 4975.2 5344.0 5384.8 3063.5 3446.6 4008.4 4156.8 4195.4 3867.6 4177.3 4181.2 4194.6 4213.3 3630.9 4062.8 4076.4 4084.4 4104.9 3391.4 3416.5 3499.3 3573.5 4067.3 3072.6 3565.9 3569.9 3579.6 3590.0 4171.6 4634.9 4798.9 4971.8 5158.3 3942.3 3976.4 4076.9 4401.9 4714.5 5743.1 5759.5 5766.7 5768.9 5784.8 3126.7 3767.0 3889.2 3939.1 3947.4 5858.4 6003.6 6038.5 6049.2 6059.7 3288.6 3313.9 3585.0 3950.3 3954.7 3363.7 3770.8 3989.0 4024.7 4053.6 3844.9 4081.7 4611.0 4655.2 4673.2 5077.0 5127.8 5683.7 5795.7 5833.3 1068.6 1072.7 1095.7 1104.2 1123.5 873.4 896.3 908.1 938.5 946.0 4703.8 4788.9 4908.5 5192.6 5225.4 5446.7 5601.2 5712.9 5729.1 5736.9 4207.7 4492.0 4679.7 4909.7 5164.8 2441.6 2779.2 2944.2 2957.9 2974.4 4979.6 5433.0 5817.6 5828.4 5893.8 5753.0 5794.2 5826.3 5833.7 5850.7 4816.0 5742.6 5782.7 5803.7 5866.1 4388.7 4808.7 5014.1 5255.6 5724.5 4604.6 5158.3 5362.2 5578.1 5613.1 5019.1 5121.8 5329.4 5683.1 5847.8 3159.6 3327.7 3451.7 3964.8 3964.8 5206.9 5273.8 6086.5 6114.6 6116.0 4599.6 4820.2 5410.4 5655.5 5692.3 5597.2 5798.7 5813.5 5824.8 5832.3 5214.8 5299.0 5556.3 5673.8 5690.3 5832.8 5856.6 5909.1 5922.6 5964.9 4247.7 4708.0 4977.0 5290.5 5596.8 02:55:32 INFO - PROCESS | 1641 | 02:55:32 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19718.58 Median:2501.93 stddev:28554.85 (1141.3%) stddev-sans-first:28599.13 02:55:32 INFO - PROCESS | 1641 | Values: 669.4 683.7 700.7 747.1 790.8 13990.2 14600.4 14629.8 14645.5 14678.8 11863.8 13129.9 13261.8 13880.8 14746.5 793.9 801.5 820.3 837.0 842.1 829.6 831.8 831.8 832.0 836.8 863.3 866.0 869.9 874.6 880.5 834.5 847.2 863.2 867.9 871.9 623.1 640.1 641.0 646.8 647.5 13840.3 13952.9 13968.8 13970.7 13975.7 13464.8 13747.7 13821.7 13877.5 13965.4 9300.6 11215.2 11295.0 11395.5 11511.8 3425.2 3523.6 3569.8 3614.3 3666.2 89370.6 91929.5 93261.5 93400.0 94238.5 10027.8 10091.0 10260.1 10349.0 10472.7 18815.9 19513.0 19694.3 19724.6 19758.7 7319.3 7398.6 7412.4 7475.6 7549.4 4131.5 4233.2 4258.1 4264.1 4270.0 3356.4 3451.4 3458.2 3476.0 3503.5 595.4 633.7 644.7 650.0 658.2 584.6 636.3 644.7 649.7 666.9 8582.8 8875.6 9008.4 9051.9 9178.1 458.8 539.6 555.7 633.0 671.7 3676.5 4021.6 4064.2 4521.9 4545.1 90244.0 109476.0 110032.0 110044.4 111827.0 73027.6 80958.2 82493.2 96434.0 96914.0 58767.7 64215.4 66019.3 82765.6 84987.2 9307.5 9781.9 9912.9 9928.5 9930.3 48450.0 48727.0 49108.0 55684.0 55843.9 57700.6 71799.3 72550.3 77745.0 77953.6 12112.3 12123.9 12421.9 12465.4 12586.5 13757.2 13786.6 13812.2 14125.9 14172.4 10659.7 12506.0 12838.3 13061.2 13184.0 9933.2 11665.0 12618.7 12635.5 12958.0 12284.7 12753.4 12931.9 13093.8 13229.0 10964.5 11658.4 11696.7 11842.4 11934.5 9350.6 11491.5 11513.9 11519.7 11597.9 02:55:32 INFO - PROCESS | 1641 | -------- Summary: end -------- 02:55:32 INFO - PROCESS | 1641 | 02:55:33 INFO - TEST-INFO | 1641: exit 0 02:55:33 INFO - TEST-OK | dromaeo_css | took 1115922ms 02:55:33 INFO - TEST-START | kraken 02:55:33 INFO - operating with platform_type : mac_ 02:55:33 INFO - Initialising browser for kraken test... 02:55:33 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpGaML5j/profile http://localhost:49241/getInfo.html) 02:55:34 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 02:55:36 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 02:55:36 INFO - PROCESS | 1652 | colorDepth:24 02:55:36 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 02:55:36 INFO - PROCESS | 1652 | __metrics 02:55:36 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 02:55:36 INFO - TEST-INFO | 1652: exit 0 02:55:36 INFO - Browser initialized. 02:55:36 INFO - Running cycle 1/1 for kraken test... 02:55:36 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/tmpGaML5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:48 INFO - PROCESS | 1655 | RSS: Main: 224358400 02:55:48 INFO - PROCESS | 1655 | 02:55:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:52 INFO - PROCESS | 1655 | RSS: Main: 236765184 02:55:52 INFO - PROCESS | 1655 | 02:55:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 02:55:55 INFO - PROCESS | 1655 | RSS: Main: 244367360 02:55:55 INFO - PROCESS | 1655 | 02:55:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 02:55:59 INFO - PROCESS | 1655 | RSS: Main: 248070144 02:55:59 INFO - PROCESS | 1655 | 02:56:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 02:56:02 INFO - PROCESS | 1655 | RSS: Main: 248483840 02:56:02 INFO - PROCESS | 1655 | 02:56:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:56:05 INFO - PROCESS | 1655 | RSS: Main: 248885248 02:56:05 INFO - PROCESS | 1655 | 02:56:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:08 INFO - PROCESS | 1655 | RSS: Main: 253669376 02:56:08 INFO - PROCESS | 1655 | 02:56:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:12 INFO - PROCESS | 1655 | RSS: Main: 253833216 02:56:12 INFO - PROCESS | 1655 | 02:56:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 02:56:15 INFO - PROCESS | 1655 | RSS: Main: 253210624 02:56:15 INFO - PROCESS | 1655 | 02:56:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:18 INFO - PROCESS | 1655 | RSS: Main: 252334080 02:56:18 INFO - PROCESS | 1655 | 02:56:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:20 INFO - PROCESS | 1655 | RSS: Main: 252252160 02:56:20 INFO - PROCESS | 1655 | 02:56:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:23 INFO - PROCESS | 1655 | RSS: Main: 252243968 02:56:23 INFO - PROCESS | 1655 | 02:56:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:27 INFO - PROCESS | 1655 | RSS: Main: 252567552 02:56:27 INFO - PROCESS | 1655 | 02:56:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:30 INFO - PROCESS | 1655 | RSS: Main: 252399616 02:56:30 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 02:56:32 INFO - PROCESS | 1655 | RSS: Main: 254238720 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | __start_tp_report 02:56:32 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 02:56:32 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 02:56:32 INFO - PROCESS | 1655 | |i|pagename|runs| 02:56:32 INFO - PROCESS | 1655 | |0;ai-astar;107;122;118;119;119;118;122;142;119;119 02:56:32 INFO - PROCESS | 1655 | |1;audio-beat-detection;147;116;115;146;117;113;112;113;146;111 02:56:32 INFO - PROCESS | 1655 | |2;audio-dft;195;199;197;199;196;191;200;198;240;222 02:56:32 INFO - PROCESS | 1655 | |3;audio-fft;81;58;60;87;62;61;58;59;74;63 02:56:32 INFO - PROCESS | 1655 | |4;audio-oscillator;88;71;118;56;85;105;124;100;102;90 02:56:32 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;86;89;85;88;105;88;97;104;133 02:56:32 INFO - PROCESS | 1655 | |6;imaging-darkroom;127;174;111;100;99;134;99;99;107;99 02:56:32 INFO - PROCESS | 1655 | |7;imaging-desaturate;87;88;87;97;94;90;90;122;76;142 02:56:32 INFO - PROCESS | 1655 | |8;json-parse-financial;57;55;57;56;59;67;86;91;96;87 02:56:32 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;68;75;70;81;76;75;68;70;70;71 02:56:32 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;87;84;86;89;85;88;84;87;84;88 02:56:32 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;147;176;170;164;158;148;146;152;227;168 02:56:32 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;171;177;171;166;184;186;242;168;171;167 02:56:32 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;69;68;67;68;65;67;66;69;61;90 02:56:32 INFO - PROCESS | 1655 | __end_tp_report 02:56:32 INFO - PROCESS | 1655 | __start_cc_report 02:56:32 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,988 02:56:32 INFO - PROCESS | 1655 | __end_cc_report 02:56:32 INFO - PROCESS | 1655 | __startTimestamp1479380192827__endTimestamp 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | ------- Summary: start ------- 02:56:32 INFO - PROCESS | 1655 | Number of tests: 14 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:120.50 Median:119.00 stddev:8.63 (7.3%) stddev-sans-first:7.65 02:56:32 INFO - PROCESS | 1655 | Values: 107.0 122.0 118.0 119.0 119.0 118.0 122.0 142.0 119.0 119.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:116.50 stddev:15.79 (13.6%) stddev-sans-first:14.30 02:56:32 INFO - PROCESS | 1655 | Values: 147.0 116.0 115.0 146.0 117.0 113.0 112.0 113.0 146.0 111.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:203.70 Median:199.00 stddev:15.22 (7.6%) stddev-sans-first:15.81 02:56:32 INFO - PROCESS | 1655 | Values: 195.0 199.0 197.0 199.0 196.0 191.0 200.0 198.0 240.0 222.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:66.30 Median:62.50 stddev:10.50 (16.8%) stddev-sans-first:9.70 02:56:32 INFO - PROCESS | 1655 | Values: 81.0 58.0 60.0 87.0 62.0 61.0 58.0 59.0 74.0 63.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:63.50 stddev:20.56 (32.4%) stddev-sans-first:21.69 02:56:32 INFO - PROCESS | 1655 | Values: 88.0 71.0 118.0 56.0 85.0 105.0 124.0 100.0 102.0 90.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.00 stddev:14.82 (16.8%) stddev-sans-first:15.41 02:56:32 INFO - PROCESS | 1655 | Values: 88.0 86.0 89.0 85.0 88.0 105.0 88.0 97.0 104.0 133.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:136.50 stddev:24.30 (17.8%) stddev-sans-first:25.38 02:56:32 INFO - PROCESS | 1655 | Values: 127.0 174.0 111.0 100.0 99.0 134.0 99.0 99.0 107.0 99.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:89.00 stddev:19.66 (22.1%) stddev-sans-first:20.49 02:56:32 INFO - PROCESS | 1655 | Values: 87.0 88.0 87.0 97.0 94.0 90.0 90.0 122.0 76.0 142.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:76.50 stddev:16.80 (22.0%) stddev-sans-first:17.02 02:56:32 INFO - PROCESS | 1655 | Values: 57.0 55.0 57.0 56.0 59.0 67.0 86.0 91.0 96.0 87.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:4.20 (5.7%) stddev-sans-first:4.14 02:56:32 INFO - PROCESS | 1655 | Values: 68.0 75.0 70.0 81.0 76.0 75.0 68.0 70.0 70.0 71.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:87.00 stddev:1.87 (2.2%) stddev-sans-first:1.96 02:56:32 INFO - PROCESS | 1655 | Values: 87.0 84.0 86.0 89.0 85.0 88.0 84.0 87.0 84.0 88.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:165.60 Median:166.00 stddev:24.01 (14.5%) stddev-sans-first:24.51 02:56:32 INFO - PROCESS | 1655 | Values: 147.0 176.0 170.0 164.0 158.0 148.0 146.0 152.0 227.0 168.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:174.00 stddev:22.75 (13.1%) stddev-sans-first:23.87 02:56:32 INFO - PROCESS | 1655 | Values: 171.0 177.0 171.0 166.0 184.0 186.0 242.0 168.0 171.0 167.0 02:56:32 INFO - PROCESS | 1655 | 02:56:32 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:7.75 (11.4%) stddev-sans-first:8.22 02:56:32 INFO - PROCESS | 1655 | Values: 69.0 68.0 67.0 68.0 65.0 67.0 66.0 69.0 61.0 90.0 02:56:32 INFO - PROCESS | 1655 | -------- Summary: end -------- 02:56:32 INFO - PROCESS | 1655 | 02:56:33 INFO - TEST-INFO | 1655: exit 0 02:56:33 INFO - TEST-OK | kraken | took 60480ms 02:56:33 INFO - SUITE-END | took 1176s 02:56:33 INFO - Completed test suite (00:19:36) 02:56:33 INFO - javascript benchmark 02:56:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7154.46165464515, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2921.714445643917, 3215.6945090216436, 3265.4448743713565, 3365.7475689323305, 3413.4367829308167, 5368.221607866857, 5700.429957004298, 5706.400827913067, 5760.7695692172265, 5768.105943578752, 4335.65314774818, 5696.629719068268, 5769.451902069297, 5821.621594596349, 5845.123231515275, 4289.721168124078, 5217.86955326118, 5281.419043905186, 5283.8150664726745, 5322.813701520428, 4947.183714687072, 5307.495787900143, 5325.3077099976945, 5339.385970613371, 5342.385625653042, 5155.355580552431, 5175.922361164586, 5331.067063263933, 5350.143976963686, 5392.379876314235, 5239.816606418776, 5248.134057880445, 5266.34170728659, 5270.077736396153, 5278.894422111574, 5132.332796736438, 5158.664686795346, 5203.60972927032, 5238.240455134022, 5341.359036915556, 4797.920467894731, 5170.482951704837, 5823.126531020339, 5843.240378750777, 5861.6189947653265, 5983.461488466059, 6138.508919286446, 6156.0, 6194.876102477971, 6205.6897155142515, 6122.632642041492, 6155.107509411155, 6159.922013647639, 6218.067289906505, 6229.7508099676415, 4782.832600858953, 5809.2738407699035, 5828.766849326064, 5915.231019967419, 5985.700714964234, 6186.81439556814, 6273.37266273369, 6275.905861412082, 6307.747690092345, 6310.7791227306825, 6146.846328841725, 6151.138840562325, 6157.9384206157365, 6169.0, 6182.979808331665, 6121.849304493819, 6160.1375807387, 6190.350013248634, 6215.564910456224, 6224.688765561704, 6138.570300078952, 6189.442950134509, 6199.876002479925, 6210.441060304594, 6225.750969961151, 6064.848378790565, 6105.542084343603, 6171.9691401542705, 6175.320714721377, 6205.720742566505, 4863.586595139453, 4914.017196560702, 4929.580985616191, 4932.482089380635, 4938.802447902043, 4353.238183317907, 4403.3394990751, 4404.009097952935, 4427.313766366218, 4446.421965144576, 5872.941270587325, 5905.173275741399, 5926.4369884861735, 5948.405159484017, 5949.940500595025, 4312.978435107867, 6108.633481991006, 6154.261488621304, 6154.969225153935, 6178.536609754196, 4808.134535783523, 5884.529237660977, 5893.499052580579, 5968.761249550056, 6036.426539478743, 5316.76074576645, 5447.618666693373, 5456.91814622781, 5488.17677348401, 5506.587005974568, 6175.073738939105, 6271.278802937721, 6327.651979141191, 6391.8721625566295, 6431.163948686641, 5821.388754180919, 6132.508481341157, 6197.194364732556, 6271.905921411091, 6275.466585340298, 5733.881893030819, 6388.616682999035, 6411.647359395278, 6431.1317972073175, 6432.549721519636, 4986.775595098156, 6170.3212646607935, 6177.62934223948, 6185.907211391923, 6191.783287584913, 6072.696365181811, 6075.36208698098, 6115.0273862886115, 6125.052321062068, 6173.074038894202, 4250.681198910032, 4616.238320677185, 6066.15073889647, 6116.4495195430845, 6164.907526387018, 4935.481774413778, 6138.0, 6158.137860699595, 6180.783672571439, 6200.627962322275, 5831.096180092092, 5924.11138329254, 5951.613145145551, 6064.968955277702, 6088.726007329592, 6089.969550152221, 6102.694865256808, 6123.387661233841, 6127.754889804358, 6134.191681013941, 6001.279846418458, 6023.0, 6024.789132380346, 6027.909581356195, 6030.216071910623], "value": 5635.765143605758, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.89322562584977, 476.38308390634126, 522.3209827224608, 526.4761562245563, 546.4017748086845, 38231.617683823155, 39509.20981580367, 39663.206735865264, 39697.00757481065, 39763.40354894671, 40519.0, 41083.0, 41090.79454602723, 41155.38266925998, 41177.794111029405, 9158.58786354614, 9246.260299176083, 9325.906740932605, 9339.252859771203, 9363.859542106873, 9163.633454661838, 9186.081391860827, 9302.767430814216, 9358.438493690366, 9371.062893710608, 9182.72451826443, 9337.953310233474, 9374.156325930664, 9383.5308234588, 9392.483413412294, 9297.0, 9379.577918993662, 9380.390274632127, 9384.108509691569, 9420.152186303198, 9045.095490450967, 9131.543422828832, 9134.725958221265, 9217.953910230406, 9229.169374756304, 38639.61360386416, 38982.83051508459, 39042.41436378456, 39125.0, 39161.60838391608, 3278.1149089745873, 3302.5046243063493, 3320.5849268841393, 3346.4478361070396, 3403.1662242750435, 29590.0, 29958.55062174069, 29975.0, 30241.243968900733, 30478.0, 3144.7326977206967, 3196.9200769980703, 3200.519922011694, 3209.2297848516187, 3230.596175478065, 497377.0, 504919.0, 505997.0, 506992.0, 507109.0, 56427.0, 56459.0, 56765.0, 56933.715331423904, 57008.42991570031, 59319.51701207418, 59516.70241648851, 59562.0, 59570.40429595735, 59587.40412595905, 15685.686286274438, 15690.0, 15873.0, 15901.125438100784, 15904.12527310986, 11877.0, 12384.256944583354, 12387.504499820086, 12392.62822115338, 12452.377381130907, 15061.0, 15279.541613751606, 15500.30248638814, 15561.766573501407, 15656.843431565767, 3173.793703409271, 3270.280538281574, 3306.140403495109, 4949.356583644103, 6359.745610175633, 799.7800604833717, 833.4957350802798, 972.2125078686287, 1003.3277703938379, 1025.7589466475372, 27735.0, 29011.854940725585, 29356.706432935825, 29938.55092173619, 30033.0, 1041.510490069666, 1054.9525271362807, 1077.8221593437152, 1104.718296834302, 1110.3171549497163, 12624.684382890318, 12829.011503217016, 15629.218539073001, 15763.921180394025, 16039.278232479566, 610761.0, 611661.9416902887, 611674.0, 615521.0, 616215.0, 45141.0, 54397.0, 54404.0, 54900.0, 54981.450185498434, 1291.593148158327, 1306.660268330222, 1345.710672205461, 1346.4748747988292, 1346.7643162446532, 29110.27224319409, 29604.555931661474, 29796.553051704675, 30269.69730302669, 30356.785728571493, 47662.523374767195, 52054.219186711474, 53422.73288633532, 53647.731761342504, 56642.433575663716, 609125.0, 615779.0, 617293.0, 620309.0, 620825.8958705177, 40437.79781101076, 41013.1797364057, 41362.58637413587, 41392.79303603463, 41684.0, 43767.12465750731, 44701.0, 44800.0, 45223.547764521936, 45381.54618453773, 37004.81497592495, 37032.0, 37710.434343485416, 38850.0, 39035.21929561449, 37518.06204844901, 37829.81085094557, 38608.80695596504, 38679.80660096682, 39000.829975100794, 36372.0, 36712.63287367092, 36718.0, 36772.964400067875, 36832.3209829904, 25774.0, 30441.0, 32146.678533215305, 32484.67515324911, 34213.0, 22894.084236630348, 25271.620925685762, 25302.0, 25314.367140821625, 25807.225783226535], "value": 19334.19270777852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.66175118890635, 374.29819089207734, 379.27747640744394, 385.7878167008146, 398.8962869653891, 18209.99845008524, 19841.40475785725, 20058.297959571417, 20178.0, 20303.289384871532, 19803.702944455843, 20004.399868003948, 20107.195712171495, 20340.0, 20650.173993040262, 5505.752241149138, 5805.303363596375, 5932.644041357511, 6064.423879731418, 6127.81616551502, 5976.103584462322, 6105.145279660851, 6105.786297479589, 6115.571909966304, 6116.235470566179, 5731.742071606787, 5970.373110823366, 6006.369331220225, 6006.909896351558, 6068.878622427571, 5690.857728556778, 5937.554683398741, 5978.192943952554, 5999.880002399949, 6016.398360163992, 5114.923276150861, 5170.6122040847085, 5171.250168725552, 5176.06830770465, 5176.974115129438, 24404.02383904642, 24449.633255501183, 24500.529968201965, 24759.752402475926, 25271.747282527307, 2303.2284184798114, 2367.0531787285054, 2454.9877250613813, 2497.2882728422314, 2943.7644988400875, 14302.785458218135, 15267.160306183156, 15484.148371839545, 15573.987690800062, 15837.762433563506, 1823.2798044772242, 1860.8555738220896, 1896.1656870976726, 1896.6396384687002, 1943.2518480385013, 109120.90879091187, 111779.44110279478, 117076.0, 118428.40785796016, 119466.0, 10527.94736026315, 10562.788744225072, 10743.677689669323, 11267.887321126847, 11476.54093836254, 13468.932655336857, 13476.39356228972, 13658.180509169282, 13665.931670341584, 13855.722885542233, 8030.879536806952, 8452.66189352419, 8536.786580335542, 8680.218780309677, 8700.260477859452, 8147.185281471805, 8325.708600199085, 8362.749117526484, 8367.874481882776, 8768.956155219183, 5510.669359838423, 6494.9350506495275, 6706.792777300036, 6722.630255336004, 6744.258131605519, 1573.299881552721, 1828.6799810033192, 1859.7675290588677, 1868.3367404571454, 1869.1121717184228, 753.8605358008786, 907.981840363189, 939.7227817793768, 947.6872632031414, 1012.7468132966758, 20845.478863028544, 21419.892900535397, 21633.0, 21735.0, 21795.019224134634, 973.3916302311055, 977.3158788847835, 982.4841957971979, 985.2905907746411, 1044.5717255925185, 11332.71668208285, 11552.711182220344, 11558.306501609763, 11577.6526704199, 11618.0, 621262.8936855287, 628033.0, 632784.0, 633579.0, 641603.0, 82856.58571707102, 107384.46307768411, 113397.0, 118407.40796295964, 118780.21829672562, 817.8691409374591, 854.4446110028531, 957.167264479907, 987.9506024698736, 1009.1422291052693, 18675.813241867407, 18957.71563426522, 19243.03784810782, 19323.0, 19355.8064419354, 50683.0, 51333.0, 51524.742376287875, 51814.70463238449, 52640.7367963173, 67117.3288267111, 75281.0, 77184.0, 77767.61116194609, 83850.0, 7541.773746787605, 7947.284744373034, 8017.398695097774, 8140.087079536423, 8174.632141553526, 11301.830472542753, 12588.055895807667, 12598.937005314914, 12603.621891343275, 12788.616341509769, 10388.272820902464, 10823.512941917475, 10852.294600850919, 10886.346819190874, 11142.932829517005, 10836.891631083903, 10881.183911206534, 10886.23796334249, 10899.0, 10908.454577271263, 11054.0, 11089.27919685218, 11300.604478843201, 11444.484998175269, 11560.595379161688, 7939.84120317602, 8087.433879628369, 8117.756467305991, 8143.0, 8256.628451719567, 9560.330776845554, 10540.736481588021, 11033.779324413626, 11056.502457389275, 11161.72095697614], "value": 9674.386004611955, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.8637829406207, 1471.7931296337001, 1668.9916550417247, 1777.3157334426242, 1812.6193499365124, 7344.596047217401, 7628.084629844427, 8092.393070519713, 8561.657533698652, 8571.142885711433, 7991.720289789859, 8295.1290114538, 8313.50118992861, 8414.158584141584, 8428.452150610206, 2319.8376113672093, 2358.6108292131776, 2358.6579945907833, 2359.752226016269, 2367.4554852383962, 2351.247600767755, 2370.0519792083132, 2401.435662619283, 2402.531506356261, 2403.507281007398, 2336.0772494864605, 2342.8360014798973, 2359.6224604063354, 2363.0, 2363.2201373546773, 2296.3799774060994, 2299.3906614747107, 2312.225404489498, 2324.732655744586, 2332.288651961151, 2344.824138189643, 2357.587422201108, 2377.702787151606, 2381.89281482332, 2383.8569685818907, 8387.287080598157, 8444.493330400133, 8504.064552899237, 8519.0, 8529.74410767678, 5150.124478838569, 5316.760745766411, 5328.973355133199, 5329.573634109262, 5332.360116786011, 3453.4474484082425, 3508.5965114011706, 3512.824358782076, 3565.108722819295, 3588.551431071116, 1014.3052009373529, 1029.1355261580234, 1065.0893486069376, 1067.2795862792661, 1071.6463567022943, 10912.563497460093, 10963.397013164273, 11054.889451105466, 11089.0, 11093.3898635575, 4497.8425755098415, 4658.813647454132, 4756.072565849626, 4757.381540399726, 4772.76136193189, 9418.811623767486, 9499.525023748924, 9506.809863802686, 9511.619535218651, 9520.476373799369, 4299.54854740254, 5192.9740351298005, 5236.711980841014, 5248.501392367719, 5268.683878967274, 4321.330193819963, 4331.696781225284, 4628.930566041512, 4803.135435621622, 4833.975830120827, 3064.6169228846393, 3294.341131773655, 3390.813505257185, 3678.2459595782802, 3953.0710283083454, 1035.1625864091297, 1066.8637900635797, 1228.729679470515, 1278.2586100061942, 1288.2463758701265, 775.1279810213509, 791.7941335252875, 852.4416507187802, 911.7811725185908, 922.6724512797995, 5534.944650553523, 5712.914306285409, 5810.273715785527, 5851.414858514199, 5863.296404431496, 802.8033131882726, 914.835329640671, 926.4904302633524, 934.1919239857474, 941.8069295794346, 3823.502944617182, 3841.7118716096406, 3847.6537111659527, 3884.320243957296, 3900.531936167621, 7728.343090837229, 10080.546375413123, 10083.394996300245, 10259.640912568024, 10291.33106348085, 10200.4389758564, 10206.13247873939, 10208.285420020677, 10231.925647807022, 10289.125424338865, 7810.6875724971505, 7998.160193179749, 8017.959910200411, 8020.197980201933, 8042.356611471068, 5403.189521571796, 5575.275214222125, 5612.719364031864, 5724.656520608777, 5868.823935281948, 9322.254219662274, 9378.95310523443, 9463.337566370288, 9476.099770521789, 9493.66772162971, 9361.812763744823, 9402.2948278878, 9534.332596718163, 9658.71023869285, 9730.36752611078, 7096.822579435349, 7174.246704095995, 7227.096612923385, 7246.275372462712, 7279.890801637874, 7784.883226751716, 7822.256885595859, 7858.960705196438, 7889.881651775343, 7905.169957154416, 7041.859162816818, 7095.886069681165, 7158.928410716035, 7281.199068102399, 7291.08861392326, 6951.235364110045, 7044.401225895651, 7052.118485189351, 7133.678984445816, 7195.568265904062, 6718.563293385914, 6727.0, 6799.5920244785475, 6801.591904485746, 6801.829954251183, 4812.542808433193, 4837.975810120927, 4874.2201247800185, 4894.510548945077, 4911.435184953776, 4668.206404911241, 4731.976340118277, 4802.207635740064, 4809.158397280392, 4820.108279968077], "value": 4431.220757774843, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.33788004270644, 307.4880324260107, 313.28883434603443, 314.2207325831935, 316.82732910563743, 4871.7333493291735, 5239.79484718515, 5246.658967167132, 5557.944420555793, 5593.105103183487, 4238.364245363197, 4378.5840345167235, 4975.154223781957, 5343.984642917843, 5384.757685904134, 3063.5251536011842, 3446.5864096308414, 4008.4388185653884, 4156.833726650931, 4195.370694395834, 3867.57456679765, 4177.289860723684, 4181.163767246548, 4194.615776793651, 4213.262679031172, 3630.9273814523694, 4062.8171732272117, 4076.429299898017, 4084.36692312692, 4104.8563300284495, 3391.4404123319623, 3416.4533674612067, 3499.3001399720156, 3573.5175751273764, 4067.2882245607198, 3072.6159230096237, 3565.8751943682105, 3569.9107522311892, 3579.570451545805, 3589.971666008723, 4171.6036976487185, 4634.907301853944, 4798.856034318976, 4971.801127954877, 5158.329417175781, 3942.2601292102, 3976.403539469074, 4076.9388459173138, 4401.92152922536, 4714.528547145293, 5743.10323305455, 5759.452851979056, 5766.654000759968, 5768.942310576883, 5784.797532086399, 3126.6873312668777, 3767.0, 3889.202713443737, 3939.0546268895546, 3947.4276229946786, 5858.443447872488, 6003.579749417542, 6038.456538911475, 6049.243844519435, 6059.697015149269, 3288.588926384202, 3313.93372132556, 3584.982075089608, 3950.308695978192, 3954.7429417087797, 3363.6972672459106, 3770.7737535747942, 3989.0, 4024.7182697210915, 4053.5946405359227, 3844.9426407738097, 4081.6530594899173, 4610.985583171697, 4655.162070827284, 4673.182193116191, 5076.959223359203, 5127.769250383742, 5683.687397193194, 5795.7391917362975, 5833.270841144857, 1068.5992752717732, 1072.7318170457386, 1095.6932059023486, 1104.1994553948484, 1123.5393488669606, 873.3799002708022, 896.2605850173633, 908.1281969309537, 938.4510061613896, 945.9925179683615, 4703.8484215575645, 4788.924987149332, 4908.545727136432, 5192.584593232532, 5225.399079105951, 5446.673199608036, 5601.243832082698, 5712.885742285131, 5729.1119876419225, 5736.852629474122, 4207.663386929038, 4491.955080449219, 4679.67242293043, 4909.680870743462, 5164.764892787953, 2441.593976402908, 2779.2496026072845, 2944.219781757836, 2957.896473623413, 2974.3605124897817, 4979.57673597741, 5432.972835135799, 5817.632856278771, 5828.358880523139, 5893.764249430061, 5753.0, 5794.159846822187, 5826.271716035496, 5833.7374818133285, 5850.707464626752, 4815.951840481621, 5742.59801813869, 5782.6819524925695, 5803.709814509342, 5866.090755932837, 4388.692791504564, 4808.663393562417, 5014.08901057176, 5255.553277971415, 5724.513416359656, 4604.6186144155945, 5158.252053452304, 5362.249285100011, 5578.103444828777, 5613.073842815889, 5019.117830813445, 5121.8463446096675, 5329.427818793542, 5683.062294721325, 5847.766089356548, 3159.605049368829, 3327.667233276653, 3451.706604938508, 3964.759910650473, 3964.821583028713, 5206.921896171636, 5273.789048438173, 6086.452219300284, 6114.571979961538, 6116.0, 4599.609033232213, 4820.228763397839, 5410.3507579090765, 5655.519280861173, 5692.3169219692245, 5597.236870385816, 5798.723721097566, 5813.505852002627, 5824.767009319749, 5832.300123985149, 5214.791408343775, 5299.0, 5556.305461817273, 5673.77304907799, 5690.345610254708, 5832.795852145155, 5856.603170161381, 5909.143174239625, 5922.585419020627, 5964.9105263420215, 4247.745135291769, 4708.0, 4977.0, 5290.518654776669, 5596.772744066217], "value": 4010.754223952631, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.4042302350908, 683.6889215406991, 700.719712115154, 747.0960138232738, 790.758818560339, 13990.160590364585, 14600.41598336068, 14629.78055329171, 14645.487407940724, 14678.77981830272, 11863.822042669346, 13129.949604031679, 13261.801072983888, 13880.791788123186, 14746.483873064444, 793.8729803231485, 801.527099011583, 820.3437250199817, 836.9874451883227, 842.1115722912325, 829.5561874397199, 831.7837362285788, 831.8086840026798, 831.995840020799, 836.8368168207202, 863.2532859076916, 866.0, 869.8651708985086, 874.5802015032788, 880.4541184465609, 834.5326617094447, 847.2205570874779, 863.1799790199336, 867.895852497698, 871.8866547348836, 623.1027320658283, 640.1134428816076, 641.0096401060326, 646.7930262316061, 647.5014239035916, 13840.30798460083, 13952.860471395257, 13968.790468142986, 13970.720585588333, 13975.720485590231, 13464.798028029587, 13747.656308592264, 13821.723565528633, 13877.514286999907, 13965.441382344694, 9300.581473833694, 11215.15886308522, 11295.0, 11395.487203075882, 11511.827322590168, 3425.246445781924, 3523.594786599548, 3569.8215089245696, 3614.3313487004725, 3666.24841907411, 89370.5531472345, 91929.54035229849, 93261.53369233178, 93400.0, 94238.52880735553, 10027.79944401108, 10091.0, 10260.076593106507, 10349.0, 10472.68581942543, 18815.90592047031, 19513.0, 19694.31069912546, 19724.605507889763, 19758.70361944572, 7319.268073192638, 7398.593077380688, 7412.407007439392, 7475.5888426136, 7549.396048316122, 4131.462909821764, 4233.174530966494, 4258.1057977825, 4264.0832221072615, 4270.0, 3356.3622911646708, 3451.4132597458492, 3458.170039190576, 3475.991962330946, 3503.5445392098864, 595.4462350014528, 633.6989929783316, 644.7421031587403, 649.9967500162469, 658.1575583253443, 584.5820238529471, 636.2555809702659, 644.7002144003061, 649.7108786590017, 666.8732940741244, 8582.785430364165, 8875.600597973107, 9008.369414141078, 9051.864222036675, 9178.128077832594, 458.76373667561234, 539.5683453237394, 555.7443575955106, 632.9840605827673, 671.7111641993989, 3676.540432445944, 4021.6380525752825, 4064.227796718614, 4521.932171017437, 4545.090981803586, 90244.0, 109476.0, 110032.0, 110044.4497777506, 111827.0, 73027.63486182535, 80958.19041809624, 82493.17506824975, 96434.0, 96914.0308596919, 58767.706161468916, 64215.35784642187, 66019.33980660228, 82765.58617206996, 84987.15012849915, 9307.534623268673, 9781.902180978099, 9912.900870991198, 9928.503574821374, 9930.25523085757, 48450.0, 48727.0254594899, 49108.0, 55684.0, 55843.88312233651, 57700.55748606318, 71799.28200718135, 72550.28423152478, 77745.0, 77953.61023194848, 12112.333821639895, 12123.878761212274, 12421.875781242434, 12465.376731163587, 12586.521128584134, 13757.243351615758, 13786.586402407944, 13812.24032678172, 14125.858741412454, 14172.433102675777, 10659.680209593724, 12506.0, 12838.29389383593, 13061.21632702041, 13184.0, 9933.205343572641, 11665.0, 12618.684532886751, 12635.494580217057, 12958.0, 12284.692882678004, 12753.362331883183, 12931.870681293067, 13093.803592946304, 13229.0, 10964.506597202986, 11658.417079146178, 11696.70758231051, 11842.407879605813, 11934.462949167482, 9350.625974960925, 11491.48288327044, 11513.88486115128, 11519.654410367702, 11597.942010289895], "value": 7157.524320762642, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 122.0, 118.0, 119.0, 119.0, 118.0, 122.0, 142.0, 119.0, 119.0], "value": 120.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 115.0, 146.0, 117.0, 113.0, 112.0, 113.0, 146.0, 111.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 197.0, 199.0, 196.0, 191.0, 200.0, 198.0, 240.0, 222.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 87.0, 62.0, 61.0, 58.0, 59.0, 74.0, 63.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 118.0, 56.0, 85.0, 105.0, 124.0, 100.0, 102.0, 90.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 85.0, 88.0, 105.0, 88.0, 97.0, 104.0, 133.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 174.0, 111.0, 100.0, 99.0, 134.0, 99.0, 99.0, 107.0, 99.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 97.0, 94.0, 90.0, 90.0, 122.0, 76.0, 142.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 56.0, 59.0, 67.0, 86.0, 91.0, 96.0, 87.0], "value": 71.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 70.0, 81.0, 76.0, 75.0, 68.0, 70.0, 70.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 89.0, 85.0, 88.0, 84.0, 87.0, 84.0, 88.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 176.0, 170.0, 164.0, 158.0, 148.0, 146.0, 152.0, 227.0, 168.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 177.0, 171.0, 166.0, 184.0, 186.0, 242.0, 168.0, 171.0, 167.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 68.0, 65.0, 67.0, 66.0, 69.0, 61.0, 90.0], "value": 69.0, "unit": "score"}]}]} 02:56:34 INFO - Return code: 0 02:56:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:56:34 ERROR - # TBPL SUCCESS # 02:56:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:34 INFO - 2016-11-17 02:56:34.122 screenresolution[1660:10479] starting screenresolution argv=screenresolution get 02:56:34 INFO - 2016-11-17 02:56:34.125 screenresolution[1660:10479] Display 0: 1600x1200x32@60 02:56:34 INFO - 2016-11-17 02:56:34.131 screenresolution[1661:10482] starting screenresolution argv=screenresolution list 02:56:34 INFO - Available Modes on Display 0 02:56:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:34 INFO - Intel Iris: 02:56:34 INFO - Chipset Model: Intel Iris 02:56:34 INFO - Type: GPU 02:56:34 INFO - Bus: Built-In 02:56:34 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:34 INFO - Vendor: Intel (0x8086) 02:56:34 INFO - Device ID: 0x0a2e 02:56:34 INFO - Revision ID: 0x0009 02:56:34 INFO - Displays: 02:56:34 INFO - Display: 02:56:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:34 INFO - Display Serial Number: 1600x1200 60 02:56:34 INFO - Main Display: Yes 02:56:34 INFO - Mirror: Off 02:56:34 INFO - Online: Yes 02:56:34 INFO - Rotation: Supported 02:56:34 INFO - Return code: 0 02:56:34 INFO - Running post-action listener: _resource_record_post_action 02:56:34 INFO - [mozharness: 2016-11-17 10:56:34.368403Z] Finished run-tests step (success) 02:56:34 INFO - Running post-run listener: _resource_record_post_run 02:56:34 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37630976; Write bytes: 657131520; Read time: 242; Write time: 1911 02:56:34 INFO - TinderboxPrint: CPU usage
54.3% 02:56:34 INFO - TinderboxPrint: I/O read bytes / time
37,630,976 / 242 02:56:34 INFO - TinderboxPrint: I/O write bytes / time
657,131,520 / 1,911 02:56:34 INFO - TinderboxPrint: CPU idle
2,209.3 (45.7%) 02:56:34 INFO - TinderboxPrint: CPU system
979.8 (20.3%) 02:56:34 INFO - TinderboxPrint: CPU user
1,648.6 (34.1%) 02:56:34 INFO - TinderboxPrint: Swap in / out
390,619,136 / 0 02:56:34 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 350505472; Write bytes: 351047168; Read time: 27002; Write time: 732 02:56:34 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35529728; Write bytes: 299129344; Read time: 219; Write time: 1151 02:56:34 INFO - Running post-run listener: _upload_blobber_files 02:56:34 INFO - Blob upload gear active. 02:56:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:34 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 02:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:35 INFO - (blobuploader) - INFO - Done attempting. 02:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:37 INFO - (blobuploader) - INFO - Done attempting. 02:56:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:56:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:39 INFO - (blobuploader) - INFO - Done attempting. 02:56:39 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:39 INFO - Return code: 0 02:56:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac60f87a5621f1161e9d0d355db2fa799c6e212bf3bedc68329c2bc1fb6ad786f9b8149a18c4a31de048c7dc5ded30bb7a53f0f6c889104370ff8a4610414264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea001ab1ebfa2140afabd04afd2fae73f6d9bd7a262addb45ff4db7d98ff6375be17e84bd697c10b3322f2dfc5bb42de4b9bf0cc6c3b7291abc8e945eef94b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7a09101d146363183ea8dd6762b032c219dfe09dfbf77a7e5e5fa94f35bb20be412748546df2e5a6a62f236ce0718a84a23f4afd06ea9bcc69d57cf19ea1434"} 02:56:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:39 INFO - Contents: 02:56:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac60f87a5621f1161e9d0d355db2fa799c6e212bf3bedc68329c2bc1fb6ad786f9b8149a18c4a31de048c7dc5ded30bb7a53f0f6c889104370ff8a4610414264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea001ab1ebfa2140afabd04afd2fae73f6d9bd7a262addb45ff4db7d98ff6375be17e84bd697c10b3322f2dfc5bb42de4b9bf0cc6c3b7291abc8e945eef94b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7a09101d146363183ea8dd6762b032c219dfe09dfbf77a7e5e5fa94f35bb20be412748546df2e5a6a62f236ce0718a84a23f4afd06ea9bcc69d57cf19ea1434"} 02:56:39 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:39 INFO - Copying logs to upload dir... 02:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.339605 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-17 02:56:39.902202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 02:56:39.905960) ========= 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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac60f87a5621f1161e9d0d355db2fa799c6e212bf3bedc68329c2bc1fb6ad786f9b8149a18c4a31de048c7dc5ded30bb7a53f0f6c889104370ff8a4610414264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea001ab1ebfa2140afabd04afd2fae73f6d9bd7a262addb45ff4db7d98ff6375be17e84bd697c10b3322f2dfc5bb42de4b9bf0cc6c3b7291abc8e945eef94b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7a09101d146363183ea8dd6762b032c219dfe09dfbf77a7e5e5fa94f35bb20be412748546df2e5a6a62f236ce0718a84a23f4afd06ea9bcc69d57cf19ea1434"} build_url:https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010947 build_url: 'https://queue.taskcluster.net/v1/task/E3jXRz-fTjKFR8t3ZeaXyg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac60f87a5621f1161e9d0d355db2fa799c6e212bf3bedc68329c2bc1fb6ad786f9b8149a18c4a31de048c7dc5ded30bb7a53f0f6c889104370ff8a4610414264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cea001ab1ebfa2140afabd04afd2fae73f6d9bd7a262addb45ff4db7d98ff6375be17e84bd697c10b3322f2dfc5bb42de4b9bf0cc6c3b7291abc8e945eef94b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7a09101d146363183ea8dd6762b032c219dfe09dfbf77a7e5e5fa94f35bb20be412748546df2e5a6a62f236ce0718a84a23f4afd06ea9bcc69d57cf19ea1434"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 02:56:39.938296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 02:56:39.938638) ========= 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.uZUL6V7tpi/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.9QsJjYPO9c/Listeners TMPDIR=/var/folders/kk/d_yy2jqj1p3cq7ckfwf2mf2800000w/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.005351 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 02:56:39.987367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 02:56:39.987698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 02:56:39.988080) ========= ========= Total master_lag: 0.17 =========