builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0015 starttime: 1482853336.79 results: success (0) buildid: 20161227063837 builduid: d2650c098b534fe594782f1b677cb839 revision: 2c316d8a97781a4c47d648bc87a00ff1d5155749 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:16.790179) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:16.790866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:16.791152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:16.881974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:16.882387) ========= 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.EjqozAzxDq/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.mmJpomwjVV/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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-12-27 07:42:16-- 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% 7.74M=0.002s 2016-12-27 07:42:17 (7.74 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.605635 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.534686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.534959) ========= 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.EjqozAzxDq/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.mmJpomwjVV/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.019169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.584217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-27 07:42:17.584538) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2c316d8a97781a4c47d648bc87a00ff1d5155749 --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 2c316d8a97781a4c47d648bc87a00ff1d5155749 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EjqozAzxDq/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.mmJpomwjVV/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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-12-27 07:42:17,660 truncating revision to first 12 chars 2016-12-27 07:42:17,660 Setting DEBUG logging. 2016-12-27 07:42:17,660 attempt 1/10 2016-12-27 07:42:17,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2c316d8a9778?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-27 07:42:18,737 unpacking tar archive at: mozilla-aurora-2c316d8a9778/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328646 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-27 07:42:18.939282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.939980) ========= script_repo_revision: 2c316d8a97781a4c47d648bc87a00ff1d5155749 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.940815) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.941236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.961450) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-27 07:42:18.961820) ========= /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.EjqozAzxDq/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.mmJpomwjVV/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:19 INFO - MultiFileLogger online at 20161227 07:42:19 in /builds/slave/test 07:42:19 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 07:42:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:19 INFO - {'append_to_log': False, 07:42:19 INFO - 'base_work_dir': '/builds/slave/test', 07:42:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:42:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:19 INFO - 'branch': 'Mozilla-Aurora', 07:42:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:19 INFO - 'config_files': ('talos/mac_config.py',), 07:42:19 INFO - 'default_actions': ('clobber', 07:42:19 INFO - 'read-buildbot-config', 07:42:19 INFO - 'download-and-extract', 07:42:19 INFO - 'populate-webroot', 07:42:19 INFO - 'create-virtualenv', 07:42:19 INFO - 'install', 07:42:19 INFO - 'run-tests'), 07:42:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:19 INFO - 'download_minidump_stackwalk': True, 07:42:19 INFO - 'download_symbols': 'ondemand', 07:42:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:19 INFO - 'installer_path': 'installer.exe', 07:42:19 INFO - 'log_level': 'info', 07:42:19 INFO - 'log_name': 'talos', 07:42:19 INFO - 'log_to_console': True, 07:42:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:42:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:42:19 INFO - 'opt_config_files': (), 07:42:19 INFO - 'pip_index': False, 07:42:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:19 INFO - 'cmd': ('bash', 07:42:19 INFO - '-c', 07:42:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:19 INFO - 'enabled': True, 07:42:19 INFO - 'halt_on_failure': False, 07:42:19 INFO - 'name': 'check_screen_resolution'},), 07:42:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:19 INFO - 'cmd': ('bash', 07:42:19 INFO - '-c', 07:42:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:19 INFO - 'enabled': True, 07:42:19 INFO - 'halt_on_failure': False, 07:42:19 INFO - 'name': 'check_screen_resolution'},), 07:42:19 INFO - 'run_cmd_checks_enabled': True, 07:42:19 INFO - 'sps_profile': False, 07:42:19 INFO - 'sps_profile_interval': 0, 07:42:19 INFO - 'suite': 'dromaeojs-e10s', 07:42:19 INFO - 'system_bits': '32', 07:42:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:19 INFO - 'title': 't-yosemite-r7-0015', 07:42:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:19 INFO - 'use_talos_json': True, 07:42:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:19 INFO - 'work_dir': 'build'} 07:42:19 INFO - [mozharness: 2016-12-27 15:42:19.161650Z] Running clobber step. 07:42:19 INFO - Running pre-action listener: _resource_record_pre_action 07:42:19 INFO - Running main action method: clobber 07:42:19 INFO - rmtree: /builds/slave/test/build 07:42:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:19 INFO - Running post-action listener: _resource_record_post_action 07:42:19 INFO - [mozharness: 2016-12-27 15:42:19.782120Z] Finished clobber step (success) 07:42:19 INFO - [mozharness: 2016-12-27 15:42:19.782287Z] Running read-buildbot-config step. 07:42:19 INFO - Running pre-action listener: _resource_record_pre_action 07:42:19 INFO - Running main action method: read_buildbot_config 07:42:19 INFO - Using buildbot properties: 07:42:19 INFO - { 07:42:19 INFO - "project": "", 07:42:19 INFO - "product": "firefox", 07:42:19 INFO - "script_repo_revision": "production", 07:42:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:42:19 INFO - "repository": "", 07:42:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:42:19 INFO - "buildid": "20161227063837", 07:42:19 INFO - "pgo_build": "False", 07:42:19 INFO - "basedir": "/builds/slave/test", 07:42:19 INFO - "buildnumber": 67, 07:42:19 INFO - "slavename": "t-yosemite-r7-0015", 07:42:19 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 07:42:19 INFO - "platform": "yosemite_r7", 07:42:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:42:19 INFO - "branch": "mozilla-aurora", 07:42:19 INFO - "repo_path": "releases/mozilla-aurora", 07:42:19 INFO - "revision": "2c316d8a97781a4c47d648bc87a00ff1d5155749", 07:42:19 INFO - "stage_platform": "macosx64", 07:42:19 INFO - "builduid": "d2650c098b534fe594782f1b677cb839", 07:42:19 INFO - "slavebuilddir": "test" 07:42:19 INFO - } 07:42:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:42:19 INFO - Running post-action listener: _resource_record_post_action 07:42:19 INFO - [mozharness: 2016-12-27 15:42:19.785684Z] Finished read-buildbot-config step (success) 07:42:19 INFO - [mozharness: 2016-12-27 15:42:19.785787Z] Running download-and-extract step. 07:42:19 INFO - Running pre-action listener: _resource_record_pre_action 07:42:19 INFO - Running main action method: download_and_extract 07:42:19 INFO - mkdir: /builds/slave/test/build/tests 07:42:19 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')]} 07:42:19 INFO - trying https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:42:19 INFO - Downloading https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/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 07:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/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 07:42:20 INFO - Downloaded 1199 bytes. 07:42:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:42:20 INFO - Using the following test package requirements: 07:42:20 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:42:20 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:42:20 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:42:20 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'jsshell-mac.zip'], 07:42:20 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:42:20 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:42:20 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:42:20 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:42:20 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:42:20 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:20 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:42:20 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:42:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:42:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:42:20 INFO - Fetch https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:42:20 INFO - Http code: 200 07:42:20 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:42:20 INFO - x-amz-cf-id: 4CTeXAplvnlK3QjzhqP9HQ5XtDjZrxB4lQ0ZDjVvu5aL0RSkVC4NsQ== 07:42:20 INFO - x-amz-version-id: IPIKdDky3fPW8PBz9A.tyVVUdOEza9JP 07:42:21 INFO - Expected file size: 16268295 07:42:21 INFO - Obtained file size: 16268295 07:42:28 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 07:42:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:42:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:42:28 INFO - Fetch https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:42:28 INFO - Http code: 200 07:42:28 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 07:42:28 INFO - x-amz-cf-id: 7w8wOHyPKOAfdAPnlwzpmVYBv63JJFYwoN2hqX67YftNJRJ7_xnzQQ== 07:42:28 INFO - x-amz-version-id: IPIKdDky3fPW8PBz9A.tyVVUdOEza9JP 07:42:28 INFO - Expected file size: 16268295 07:42:28 INFO - Obtained file size: 16268295 07:42:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:42:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:42:35 INFO - Fetch https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:42:36 INFO - Http code: 200 07:42:36 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 07:42:36 INFO - x-amz-cf-id: 5XUh73TzOEF9Vb2n42HLLhBRKHvxNBt4Ubi8oaSigB9lS2-ooJcr5A== 07:42:36 INFO - x-amz-version-id: aChfRBcaajeMMEV1tLA7M.Orj0qGv4KW 07:42:36 INFO - Expected file size: 14409038 07:42:36 INFO - Obtained file size: 14409038 07:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:36 INFO - trying https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:42:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/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 07:42:39 INFO - Downloaded 109819866 bytes. 07:42:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:42:39 INFO - mkdir: /builds/slave/test/properties 07:42:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:42:39 INFO - Writing to file /builds/slave/test/properties/build_url 07:42:39 INFO - Contents: 07:42:39 INFO - build_url:https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:42:40 INFO - Running post-action listener: _resource_record_post_action 07:42:40 INFO - Running post-action listener: set_extra_try_arguments 07:42:40 INFO - [mozharness: 2016-12-27 15:42:40.153136Z] Finished download-and-extract step (success) 07:42:40 INFO - [mozharness: 2016-12-27 15:42:40.153279Z] Running populate-webroot step. 07:42:40 INFO - Running pre-action listener: _resource_record_pre_action 07:42:40 INFO - Running main action method: populate_webroot 07:42:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:42:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:42:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:42:40 INFO - '--tppagecycles', 07:42:40 INFO - '7'], 07:42:40 INFO - 'tests': ['tsvgm']}}, 07:42:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:42:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:42:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:42:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:42:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['damp', 'tps']}, 07:42:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'tests': ['damp', 'tps']}, 07:42:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['dromaeo_dom']}, 07:42:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:42:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['basic_compositor_video']}, 07:42:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:42:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['a11yr', 07:42:40 INFO - 'ts_paint', 07:42:40 INFO - 'tpaint', 07:42:40 INFO - 'sessionrestore', 07:42:40 INFO - 'sessionrestore_no_auto_restore', 07:42:40 INFO - 'tabpaint']}, 07:42:40 INFO - 'other-e10s': {'tests': ['a11yr', 07:42:40 INFO - 'ts_paint', 07:42:40 INFO - 'tpaint', 07:42:40 INFO - 'sessionrestore', 07:42:40 INFO - 'sessionrestore_no_auto_restore', 07:42:40 INFO - 'tabpaint']}, 07:42:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:42:40 INFO - 'ts_paint', 07:42:40 INFO - 'tpaint', 07:42:40 INFO - 'sessionrestore', 07:42:40 INFO - 'sessionrestore_no_auto_restore', 07:42:40 INFO - 'tabpaint']}, 07:42:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:42:40 INFO - 'ts_paint', 07:42:40 INFO - 'tpaint', 07:42:40 INFO - 'sessionrestore', 07:42:40 INFO - 'sessionrestore_no_auto_restore', 07:42:40 INFO - 'tabpaint']}, 07:42:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['a11yr', 07:42:40 INFO - 'ts_paint', 07:42:40 INFO - 'tpaint', 07:42:40 INFO - 'sessionrestore', 07:42:40 INFO - 'sessionrestore_no_auto_restore', 07:42:40 INFO - 'tabpaint']}, 07:42:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['a11yr', 07:42:40 INFO - 'ts_paint', 07:42:40 INFO - 'tpaint', 07:42:40 INFO - 'sessionrestore', 07:42:40 INFO - 'sessionrestore_no_auto_restore', 07:42:40 INFO - 'tabpaint']}, 07:42:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['tsvgx', 07:42:40 INFO - 'tsvgr_opacity', 07:42:40 INFO - 'tart', 07:42:40 INFO - 'tscrollx', 07:42:40 INFO - 'cart']}, 07:42:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:42:40 INFO - 'tsvgr_opacity', 07:42:40 INFO - 'tart', 07:42:40 INFO - 'tscrollx', 07:42:40 INFO - 'cart']}, 07:42:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'talos_options': ['--disable-e10s'], 07:42:40 INFO - 'tests': ['tp5o']}, 07:42:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'tests': ['tp5o']}, 07:42:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'talos_options': ['--disable-e10s', 07:42:40 INFO - '--xperf_path', 07:42:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:40 INFO - 'tests': ['tp5n']}, 07:42:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:40 INFO - 'talos_options': ['--xperf_path', 07:42:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:40 INFO - 'tests': ['tp5n']}}, 07:42:40 INFO - 'talos.zip': {'path': '', 07:42:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:42:40 INFO - Running post-action listener: _resource_record_post_action 07:42:40 INFO - [mozharness: 2016-12-27 15:42:40.172340Z] Finished populate-webroot step (success) 07:42:40 INFO - [mozharness: 2016-12-27 15:42:40.172477Z] Running create-virtualenv step. 07:42:40 INFO - Running pre-action listener: _resource_record_pre_action 07:42:40 INFO - Running main action method: create_virtualenv 07:42:40 INFO - Creating virtualenv /builds/slave/test/build/venv 07:42:40 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 07:42:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:42:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:42:40 INFO - Using real prefix '/tools/python27' 07:42:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:42:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:42:43 INFO - Installing pip.................done. 07:42:43 INFO - Return code: 0 07:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:42:44 INFO - Reading from file tmpfile_stdout 07:42:44 INFO - Output received: 07:42:44 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) 07:42:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:42:44 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')]} 07:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:44 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')]} 07:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:44 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:44 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 07:42:44 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 07:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:44 INFO - 'HOME': '/Users/cltbld', 07:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:44 INFO - 'LOGNAME': 'cltbld', 07:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:44 INFO - 'MOZ_NO_REMOTE': '1', 07:42:44 INFO - 'NO_EM_RESTART': '1', 07:42:44 INFO - 'PAGER': '/bin/cat', 07:42:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:44 INFO - 'PWD': '/builds/slave/test', 07:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:44 INFO - 'SHELL': '/bin/bash', 07:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:42:44 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:44 INFO - 'USER': 'cltbld', 07:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:44 INFO - 'XPC_FLAGS': '0x0', 07:42:44 INFO - 'XPC_SERVICE_NAME': '0', 07:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:44 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 07:42:44 INFO - Cleaning up... 07:42:44 INFO - Return code: 0 07:42:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:42:44 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')]} 07:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:44 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')]} 07:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:44 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:44 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 07:42:44 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 07:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:44 INFO - 'HOME': '/Users/cltbld', 07:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:44 INFO - 'LOGNAME': 'cltbld', 07:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:44 INFO - 'MOZ_NO_REMOTE': '1', 07:42:44 INFO - 'NO_EM_RESTART': '1', 07:42:44 INFO - 'PAGER': '/bin/cat', 07:42:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:44 INFO - 'PWD': '/builds/slave/test', 07:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:44 INFO - 'SHELL': '/bin/bash', 07:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:42:44 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:44 INFO - 'USER': 'cltbld', 07:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:44 INFO - 'XPC_FLAGS': '0x0', 07:42:44 INFO - 'XPC_SERVICE_NAME': '0', 07:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:44 INFO - Downloading/unpacking psutil>=3.1.1 07:42:44 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 07:42:44 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 07:42:44 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 07:42:44 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 07:42:44 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 07:42:44 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 07:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:48 INFO - Installing collected packages: psutil 07:42:48 INFO - Running setup.py install for psutil 07:42:48 INFO - building 'psutil._psutil_osx' extension 07:42:48 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 07:42:48 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 07:42:48 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 07:42:48 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 07:42:48 INFO - building 'psutil._psutil_posix' extension 07:42:48 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 07:42:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:42:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:42:49 INFO - ^ 07:42:49 INFO - 1 warning generated. 07:42:49 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 07:42:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:49 INFO - Successfully installed psutil 07:42:49 INFO - Cleaning up... 07:42:49 INFO - Return code: 0 07:42:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:49 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 07:42:49 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 07:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:49 INFO - 'HOME': '/Users/cltbld', 07:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:49 INFO - 'LOGNAME': 'cltbld', 07:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:49 INFO - 'MOZ_NO_REMOTE': '1', 07:42:49 INFO - 'NO_EM_RESTART': '1', 07:42:49 INFO - 'PAGER': '/bin/cat', 07:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:49 INFO - 'PWD': '/builds/slave/test', 07:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:49 INFO - 'SHELL': '/bin/bash', 07:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:42:49 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:49 INFO - 'USER': 'cltbld', 07:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:49 INFO - 'XPC_FLAGS': '0x0', 07:42:49 INFO - 'XPC_SERVICE_NAME': '0', 07:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:42:49 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 07:42:49 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 07:42:49 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 07:42:49 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 07:42:49 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 07:42:49 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 07:42:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:42:52 INFO - Installing collected packages: mozsystemmonitor 07:42:52 INFO - Running setup.py install for mozsystemmonitor 07:42:52 INFO - Successfully installed mozsystemmonitor 07:42:52 INFO - Cleaning up... 07:42:52 INFO - Return code: 0 07:42:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:52 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:52 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 07:42:52 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 07:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:52 INFO - 'HOME': '/Users/cltbld', 07:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:52 INFO - 'LOGNAME': 'cltbld', 07:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:52 INFO - 'MOZ_NO_REMOTE': '1', 07:42:52 INFO - 'NO_EM_RESTART': '1', 07:42:52 INFO - 'PAGER': '/bin/cat', 07:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:52 INFO - 'PWD': '/builds/slave/test', 07:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:52 INFO - 'SHELL': '/bin/bash', 07:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:42:52 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:52 INFO - 'USER': 'cltbld', 07:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:52 INFO - 'XPC_FLAGS': '0x0', 07:42:52 INFO - 'XPC_SERVICE_NAME': '0', 07:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:42:52 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 07:42:52 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 07:42:52 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 07:42:52 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 07:42:52 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 07:42:52 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 07:42:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:42:55 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 07:42:55 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 07:42:55 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 07:42:55 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 07:42:55 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 07:42:55 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 07:42:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:55 INFO - warning: no files found matching '*.txt' 07:42:55 INFO - no previously-included directories found matching 'build' 07:42:55 INFO - no previously-included directories found matching 'dist' 07:42:55 INFO - no previously-included directories found matching '.git*' 07:42:55 INFO - Installing collected packages: jsonschema, functools32 07:42:55 INFO - Running setup.py install for functools32 07:42:56 INFO - warning: no files found matching '*.txt' 07:42:56 INFO - no previously-included directories found matching 'build' 07:42:56 INFO - no previously-included directories found matching 'dist' 07:42:56 INFO - no previously-included directories found matching '.git*' 07:42:56 INFO - Successfully installed jsonschema functools32 07:42:56 INFO - Cleaning up... 07:42:56 INFO - Return code: 0 07:42:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:56 INFO - 'HOME': '/Users/cltbld', 07:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:56 INFO - 'LOGNAME': 'cltbld', 07:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:56 INFO - 'MOZ_NO_REMOTE': '1', 07:42:56 INFO - 'NO_EM_RESTART': '1', 07:42:56 INFO - 'PAGER': '/bin/cat', 07:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:56 INFO - 'PWD': '/builds/slave/test', 07:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:56 INFO - 'SHELL': '/bin/bash', 07:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:42:56 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:56 INFO - 'USER': 'cltbld', 07:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:56 INFO - 'XPC_FLAGS': '0x0', 07:42:56 INFO - 'XPC_SERVICE_NAME': '0', 07:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:42:56 INFO - Cleaning up... 07:42:56 INFO - Return code: 0 07:42:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:42:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:42:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:56 INFO - 'HOME': '/Users/cltbld', 07:42:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:56 INFO - 'LOGNAME': 'cltbld', 07:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:56 INFO - 'MOZ_NO_REMOTE': '1', 07:42:56 INFO - 'NO_EM_RESTART': '1', 07:42:56 INFO - 'PAGER': '/bin/cat', 07:42:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:56 INFO - 'PWD': '/builds/slave/test', 07:42:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:56 INFO - 'SHELL': '/bin/bash', 07:42:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:42:56 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:42:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:56 INFO - 'USER': 'cltbld', 07:42:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:56 INFO - 'XPC_FLAGS': '0x0', 07:42:56 INFO - 'XPC_SERVICE_NAME': '0', 07:42:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:59 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:00 INFO - Downloading docopt-0.6.1.tar.gz 07:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:00 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:00 INFO - Running setup.py install for blobuploader 07:43:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:00 INFO - Running setup.py install for requests 07:43:01 INFO - Running setup.py install for docopt 07:43:01 INFO - Successfully installed blobuploader requests docopt 07:43:01 INFO - Cleaning up... 07:43:01 INFO - Return code: 0 07:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:01 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:43:01 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 07:43:01 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 07:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:01 INFO - 'HOME': '/Users/cltbld', 07:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:01 INFO - 'LOGNAME': 'cltbld', 07:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:01 INFO - 'MOZ_NO_REMOTE': '1', 07:43:01 INFO - 'NO_EM_RESTART': '1', 07:43:01 INFO - 'PAGER': '/bin/cat', 07:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:01 INFO - 'PWD': '/builds/slave/test', 07:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:01 INFO - 'SHELL': '/bin/bash', 07:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:43:01 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:01 INFO - 'USER': 'cltbld', 07:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:01 INFO - 'XPC_FLAGS': '0x0', 07:43:01 INFO - 'XPC_SERVICE_NAME': '0', 07:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-nDgHJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-8U2YrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:01 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-iQsBBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-0Gx38Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-aJ5B22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-svbRxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-K6hXOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-sdq5F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MyY5xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-DqIUkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-PnkKB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-mSwJam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:02 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ntYL0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xYSWlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-oqU671-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-WUzdiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:03 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-JPeSzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:03 INFO - Running setup.py install for manifestparser 07:43:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Running setup.py install for mozcrash 07:43:03 INFO - Running setup.py install for mozdebug 07:43:03 INFO - Running setup.py install for mozdevice 07:43:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozfile 07:43:04 INFO - Running setup.py install for mozhttpd 07:43:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozinfo 07:43:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozInstall 07:43:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozleak 07:43:04 INFO - Running setup.py install for mozlog 07:43:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for moznetwork 07:43:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:05 INFO - Running setup.py install for mozprocess 07:43:05 INFO - Running setup.py install for mozprofile 07:43:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:05 INFO - Running setup.py install for mozrunner 07:43:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:05 INFO - Running setup.py install for mozscreenshot 07:43:05 INFO - Running setup.py install for moztest 07:43:05 INFO - Running setup.py install for mozversion 07:43:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:06 INFO - Cleaning up... 07:43:06 INFO - Return code: 0 07:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:06 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:43:06 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 07:43:06 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 07:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:06 INFO - 'HOME': '/Users/cltbld', 07:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:06 INFO - 'LOGNAME': 'cltbld', 07:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:06 INFO - 'MOZ_NO_REMOTE': '1', 07:43:06 INFO - 'NO_EM_RESTART': '1', 07:43:06 INFO - 'PAGER': '/bin/cat', 07:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:06 INFO - 'PWD': '/builds/slave/test', 07:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:06 INFO - 'SHELL': '/bin/bash', 07:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:43:06 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:06 INFO - 'USER': 'cltbld', 07:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:06 INFO - 'XPC_FLAGS': '0x0', 07:43:06 INFO - 'XPC_SERVICE_NAME': '0', 07:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-8pu9cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-9KK1jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-_lr3HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-wYIlf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-_U11yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:06 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6vWw8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xZ1TI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ekejZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-JaXJGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-q_ckgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-42szfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-nfLzq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-5CrG8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-pPtEIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-1H7tNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:07 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)) 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:07 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-xLbr3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:08 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)) 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:08 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-F_S3SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:10 INFO - Downloading blessings-1.6.tar.gz 07:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:10 INFO - Installing collected packages: blessings 07:43:10 INFO - Running setup.py install for blessings 07:43:11 INFO - Successfully installed blessings 07:43:11 INFO - Cleaning up... 07:43:11 INFO - Return code: 0 07:43:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:11 INFO - Reading from file tmpfile_stdout 07:43:11 INFO - Current package versions: 07:43:11 INFO - blessings == 1.6 07:43:11 INFO - blobuploader == 1.2.4 07:43:11 INFO - docopt == 0.6.1 07:43:11 INFO - functools32 == 3.2.3-2 07:43:11 INFO - jsonschema == 2.5.1 07:43:11 INFO - manifestparser == 1.1 07:43:11 INFO - mozInstall == 1.12 07:43:11 INFO - mozcrash == 1.0 07:43:11 INFO - mozdebug == 0.1 07:43:11 INFO - mozdevice == 0.48 07:43:11 INFO - mozfile == 1.2 07:43:11 INFO - mozhttpd == 0.7 07:43:11 INFO - mozinfo == 0.9 07:43:11 INFO - mozleak == 0.1 07:43:11 INFO - mozlog == 3.4 07:43:11 INFO - moznetwork == 0.27 07:43:11 INFO - mozprocess == 0.23 07:43:11 INFO - mozprofile == 0.28 07:43:11 INFO - mozrunner == 6.13 07:43:11 INFO - mozscreenshot == 0.1 07:43:11 INFO - mozsystemmonitor == 0.3 07:43:11 INFO - moztest == 0.7 07:43:11 INFO - mozversion == 1.4 07:43:11 INFO - psutil == 3.1.1 07:43:11 INFO - requests == 1.2.3 07:43:11 INFO - wsgiref == 0.1.2 07:43:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:11 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')]} 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 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')]} 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:43:11 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 07:43:11 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 07:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:11 INFO - 'HOME': '/Users/cltbld', 07:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:11 INFO - 'LOGNAME': 'cltbld', 07:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:11 INFO - 'MOZ_NO_REMOTE': '1', 07:43:11 INFO - 'NO_EM_RESTART': '1', 07:43:11 INFO - 'PAGER': '/bin/cat', 07:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:11 INFO - 'PWD': '/builds/slave/test', 07:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:11 INFO - 'SHELL': '/bin/bash', 07:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:43:11 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:11 INFO - 'USER': 'cltbld', 07:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:11 INFO - 'XPC_FLAGS': '0x0', 07:43:11 INFO - 'XPC_SERVICE_NAME': '0', 07:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 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)) 07:43:11 INFO - Cleaning up... 07:43:11 INFO - Return code: 0 07:43:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:11 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')]} 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 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')]} 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 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 0x10e3f6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbabc971d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, '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.EjqozAzxDq/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.mmJpomwjVV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 07:43:11 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 07:43:11 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 07:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:11 INFO - 'HOME': '/Users/cltbld', 07:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:11 INFO - 'LOGNAME': 'cltbld', 07:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:11 INFO - 'MOZ_NO_REMOTE': '1', 07:43:11 INFO - 'NO_EM_RESTART': '1', 07:43:11 INFO - 'PAGER': '/bin/cat', 07:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:11 INFO - 'PWD': '/builds/slave/test', 07:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:11 INFO - 'SHELL': '/bin/bash', 07:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:43:11 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:11 INFO - 'USER': 'cltbld', 07:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:11 INFO - 'XPC_FLAGS': '0x0', 07:43:11 INFO - 'XPC_SERVICE_NAME': '0', 07:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:11 INFO - Cleaning up... 07:43:11 INFO - Return code: 0 07:43:11 INFO - Running post-action listener: _resource_record_post_action 07:43:11 INFO - Running post-action listener: _start_resource_monitoring 07:43:11 INFO - Starting resource monitoring. 07:43:11 INFO - [mozharness: 2016-12-27 15:43:11.963151Z] Finished create-virtualenv step (success) 07:43:11 INFO - [mozharness: 2016-12-27 15:43:11.964186Z] Running install step. 07:43:11 INFO - Running pre-action listener: _resource_record_pre_action 07:43:11 INFO - Running main action method: install 07:43:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:12 INFO - Reading from file tmpfile_stdout 07:43:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:12 INFO - Reading from file tmpfile_stdout 07:43:12 INFO - Output received: 07:43:12 INFO - Usage: mozinstall [options] installer 07:43:12 INFO - Options: 07:43:12 INFO - -h, --help show this help message and exit 07:43:12 INFO - -d DEST, --destination=DEST 07:43:12 INFO - Directory to install application into. [default: 07:43:12 INFO - "/builds/slave/test"] 07:43:12 INFO - --app=APP Application being installed. [default: firefox] 07:43:12 INFO - mkdir: /builds/slave/test/build/application 07:43:12 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'] 07:43:12 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 07:43:43 INFO - Reading from file tmpfile_stdout 07:43:43 INFO - Output received: 07:43:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:43:43 INFO - Running post-action listener: _resource_record_post_action 07:43:43 INFO - [mozharness: 2016-12-27 15:43:43.322500Z] Finished install step (success) 07:43:43 INFO - [mozharness: 2016-12-27 15:43:43.322633Z] Running run-tests step. 07:43:43 INFO - Running pre-action listener: _resource_record_pre_action 07:43:43 INFO - Running main action method: run_tests 07:43:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:43:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:43:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:43:43 INFO - 2016-12-27 07:43:43.337 screenresolution[6423:121205] starting screenresolution argv=screenresolution get 07:43:43 INFO - 2016-12-27 07:43:43.339 screenresolution[6423:121205] Display 0: 1600x1200x32@60 07:43:43 INFO - 2016-12-27 07:43:43.345 screenresolution[6424:121207] starting screenresolution argv=screenresolution list 07:43:43 INFO - Available Modes on Display 0 07:43:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:43:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:43:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:43:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:43:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:43:43 INFO - Intel Iris: 07:43:43 INFO - Chipset Model: Intel Iris 07:43:43 INFO - Type: GPU 07:43:43 INFO - Bus: Built-In 07:43:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:43:43 INFO - Vendor: Intel (0x8086) 07:43:43 INFO - Device ID: 0x0a2e 07:43:43 INFO - Revision ID: 0x0009 07:43:43 INFO - Displays: 07:43:43 INFO - Display: 07:43:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:43:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:43:43 INFO - Display Serial Number: 1600x1200 60 07:43:43 INFO - Main Display: Yes 07:43:43 INFO - Mirror: Off 07:43:43 INFO - Online: Yes 07:43:43 INFO - Rotation: Supported 07:43:43 INFO - Return code: 0 07:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:43 INFO - Python 2.7.3 07:43:43 INFO - Return code: 0 07:43:43 INFO - grabbing minidump binary from tooltool 07:43:43 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')]} 07:43:43 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 0x10e20ad30>, '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 0x10e070db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e202b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:43 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 07:43:43 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 07:43:43 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 07:43:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:43 INFO - Return code: 0 07:43:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:43:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:43:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:43 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/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--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 07:43:43 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/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --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 07:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjqozAzxDq/Render', 07:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:43 INFO - 'HOME': '/Users/cltbld', 07:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:43 INFO - 'LOGNAME': 'cltbld', 07:43:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:43 INFO - 'MOZ_NO_REMOTE': '1', 07:43:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:43 INFO - 'NO_EM_RESTART': '1', 07:43:43 INFO - 'PAGER': '/bin/cat', 07:43:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:43 INFO - 'PWD': '/builds/slave/test', 07:43:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:43 INFO - 'SHELL': '/bin/bash', 07:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mmJpomwjVV/Listeners', 07:43:43 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 07:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:43 INFO - 'USER': 'cltbld', 07:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:43 INFO - 'XPC_FLAGS': '0x0', 07:43:43 INFO - 'XPC_SERVICE_NAME': '0', 07:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:43 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/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--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 07:43:43 INFO - mozversion application_buildid: 20161227063837 07:43:43 INFO - mozversion application_changeset: 2c316d8a97781a4c47d648bc87a00ff1d5155749 07:43:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:43:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:43 INFO - mozversion application_name: Firefox 07:43:43 INFO - mozversion application_remotingname: firefox-dev 07:43:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:43:43 INFO - mozversion application_vendor: Mozilla 07:43:43 INFO - mozversion application_version: 52.0a2 07:43:43 INFO - mozversion platform_buildid: 20161227063837 07:43:43 INFO - mozversion platform_changeset: 2c316d8a97781a4c47d648bc87a00ff1d5155749 07:43:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:43:43 INFO - mozversion platform_version: 52.0a2 07:43:43 INFO - using testdate: 1482853423 07:43:43 INFO - actual date: 1482853423 07:43:43 INFO - starting webserver on 'localhost:57461' 07:43:43 INFO - SUITE-START | Running 2 tests 07:43:43 INFO - TEST-START | dromaeo_css 07:43:43 INFO - operating with platform_type : mac_ 07:43:43 INFO - Initialising browser for dromaeo_css test... 07:43:43 INFO - TEST-INFO | started process 6434 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpk3gGts/profile http://localhost:57461/getInfo.html) 07:43:47 INFO - PROCESS | 6434 | 2016-12-27 07:43:47.102 plugin-container[6436:121377] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 07:43:47 INFO - PROCESS | 6434 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:43:47 INFO - PROCESS | 6434 | 2016-12-27 07:43:47.105 plugin-container[6436:121377] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a23, name = 'com.apple.CFPasteboardClient' 07:43:47 INFO - PROCESS | 6434 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:43:47 INFO - PROCESS | 6434 | 2016-12-27 07:43:47.105 plugin-container[6436:121377] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:43:47 INFO - PROCESS | 6434 | __metrics Screen width/height:1600/1200 07:43:47 INFO - PROCESS | 6434 | colorDepth:24 07:43:47 INFO - PROCESS | 6434 | Browser inner width/height: 1024/689 07:43:47 INFO - PROCESS | 6434 | __metrics 07:43:47 ERROR - PROCESS | 6434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:43:48 INFO - TEST-INFO | 6434: exit 0 07:43:48 INFO - Browser initialized. 07:43:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:48 INFO - TEST-INFO | started process 6438 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpk3gGts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:51 INFO - PROCESS | 6438 | 2016-12-27 07:43:51.052 plugin-container[6439:121521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 07:43:51 INFO - PROCESS | 6438 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:43:51 INFO - PROCESS | 6438 | 2016-12-27 07:43:51.052 plugin-container[6439:121521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x881b, name = 'com.apple.CFPasteboardClient' 07:43:51 INFO - PROCESS | 6438 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:43:51 INFO - PROCESS | 6438 | 2016-12-27 07:43:51.052 plugin-container[6439:121521] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:44:00 INFO - PROCESS | 6438 | RSS: Main: 229609472 07:44:00 INFO - PROCESS | 6438 | 07:44:50 INFO - PROCESS | 6438 | 1482853490259 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] 07:47:03 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57461/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57461/tests/dromaeo/cssquery-ext.html) 07:47:05 INFO - PROCESS | 6438 | RSS: Main: 232329216 07:47:05 INFO - PROCESS | 6438 | 07:50:08 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57461/tests/dromaeo/cssquery-ext.html (next: http://localhost:57461/tests/dromaeo/cssquery-jquery.html) 07:50:09 INFO - PROCESS | 6438 | RSS: Main: 242884608 07:50:09 INFO - PROCESS | 6438 | 07:53:11 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57461/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57461/tests/dromaeo/cssquery-mootools.html) 07:53:11 INFO - PROCESS | 6438 | RSS: Main: 245886976 07:53:11 INFO - PROCESS | 6438 | 07:56:13 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57461/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57461/tests/dromaeo/cssquery-prototype.html) 07:56:14 INFO - PROCESS | 6438 | RSS: Main: 245194752 07:56:14 INFO - PROCESS | 6438 | 07:59:17 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57461/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57461/tests/dromaeo/cssquery-yui.html) 07:59:17 INFO - PROCESS | 6438 | RSS: Main: 248758272 07:59:17 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57461/tests/dromaeo/cssquery-yui.html (next: http://localhost:57461/tests/dromaeo/cssquery-dojo.html) 08:02:20 INFO - PROCESS | 6438 | RSS: Main: 250118144 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | __start_tp_report 08:02:20 INFO - PROCESS | 6438 | _x_x_mozilla_page_load 08:02:20 INFO - PROCESS | 6438 | _x_x_mozilla_page_load_details 08:02:20 INFO - PROCESS | 6438 | |i|pagename|runs| 08:02:20 INFO - PROCESS | 6438 | |0;dojo.html;3304.1574398528373;3318.170457385654;3354.815485148316;3362.630110687824;3366.6128395234555;5598.356189038257;5635.042042852715;5658.292713410824;5708.971455142719;5720.8283751487415;5626.831195064155;5762.481376676098;5764.942350576493;5768.740406681699;5787.958167529843;5185.662931909433;5194.117000109972;5227.7908883644795;5263.26314315996;5276.92084618731;5225.163973764198;5290.841274761763;5293;5313.521783039526;5342.305500284977;5072.416672082721;5131.794728210904;5226.817061402851;5263.842084737464;5279.366476022863;4117.032497363117;4223.514295855985;4314.374415709736;4562.6121779648765;5029.1450453423;4561.977190114061;5056.165732654108;5085.415177254626;5165.509276618753;5232.293640358541;5338.893222135535;5576.079946808772;5651.1523271509195;5727.856803579903;5754.74103665336;6143.174139895654;6208.50331973441;6220.222472190976;6228.096925945712;6237.750489980395;6207.224096987877;6238.1578486904145;6258.4680302174365;6265.530085243625;6269;5660.377358490563;5738;5750.396208398141;5930.229070220887;5935.228420305376;6176.8764624707255;6185.721642526097;6210.72051757672;6235.750569977241;6243.75024999004;5170.819021334235;6107.795737660903;6117.327094019654;6124.838682352551;6141.477974372139;5664.830055098354;5810.738516766755;6115.480184184395;6208.286047104551;6215.409536094064;6063.818085457443;6068.6358818471035;6130;6171.382861713882;6181.505479561624;6131.284916201153;6153.8461538461;6192.659403732838;6192.845178870474;6246.125542424064;4854.2233242681;4899.265110233422;4902.730349830722;4911.631627627942;4930;4395.033092719596;4428.446444194476;4444.11117776446;4473.083017981306;4486.371907932892;5496.120620700669;5646.632968857011;5683.8863222736145;5750.338711048199;5756.856078598069;6161.890859645307;6170.10533472644;6181.721822517998;6239.407256310643;6257.155284036688;5781.479666830005;5819.185314056035;5824.126381042877;5832.1834943108;5863.882722345615;5369.382521010056;5381.0852155133725;5433.429489903582;5444.156155795858;5457.263269458573;5195.19474481456;6142.406692085091;6192.535559833121;6330.208723909512;6380.1067850501895;6229.595076320024;6254.374562543891;6268.435840774352;6296.590721603081;6299.055141728777;6373.864755307024;6387.808365749035;6412.03819427071;6414.647194404352;6449.7420103195345;5050.267711181931;5879.970600146972;6109.131392048963;6216.285127210429;6221.844453888508;6147.893379191788;6153.4154255345675;6169.074638804215;6186.041163619646;6234.625922444668;6138.386161383826;6163.106349579376;6173.938260617337;6197.349278325892;6211.937880621136;5968.373320801427;6097.542684298606;6146.692665366803;6156.969215153896;6177.2587289525545;5200.699825043739;5237.921431178459;5897.970510147422;5903.439173278532;6059.182010428536;6107.46191531438;6126.846828829315;6132.6920582337325;6139.079138129317;6148.907766383419;5762.135679648086;5794.0439827428;5845.678487683218;5847.970760146342;5915.438033386821 08:02:20 INFO - PROCESS | 6438 | |1;ext.html;450.14023215658096;459.4647235970095;478.98084076636934;481.29970892351633;550.6833570696848;26401;38771.80614096929;38838.223235535304;38925.41611875817;39002.414963775496;39296.60703392965;39768;39808.40287395691;39919.201615967664;39943.201135977266;9169.541522923844;9393.765155871124;9400.24798016157;9411.200047995928;9426.905730942672;9201.815963680723;9239.168474837263;9298;9312.441253524776;9344.06559344067;9308.208802251816;9323.30075244356;9324.06759324069;9329.95335023324;9353.859692104625;9222.262219022463;9266.860997085048;9271.907280927171;9302.813943721088;9306.813863722755;7729.652165652559;9119.133682300171;9125.133112354315;9129.908700912973;9149.085091490864;37766.43350349747;37954.81022594897;38005.80997095024;38084.23831523354;38175.427368589495;3234.5633339499336;3245.269814291789;3712.9814350928073;3828.3109040372724;3880.6701430378453;26176.560289184086;27829.721702783118;27918.162455126378;30231.848840755876;30475.085747427613;2976.4344774492993;3079.0916679579354;3103.798253113563;3196.888108916177;3202.1194171602997;483001;488028;488484;493060;493214;59103;60011;60139.39860601338;60160.39839601635;60178.69910650419;61607.38392616017;62447.751044979756;62485.68757156276;62601.74796504044;62775;15550.844491555166;15759.212039398213;16022.397760223885;16033.358665653242;16066.598335041484;11968;12060.21608595456;12062.698432539257;12102.636920892388;12109.939450302869;18164.63670726578;18300.725489117674;18319.725204121947;18320.908395457936;18426;3108.3006323577465;6927.618980955995;7113.857722845618;7256.492045556761;7512.39900807934;847.4533925618065;970.6166064404521;991.6628346362127;993.1378665003119;1065.6347670784435;28779.856100719782;29138.417231655247;29216.97740579112;29753;29836.701632983826;838.6310023589601;999.9400035997863;1015.0458568945168;1034.2191645307744;1049.4228174503992;15202.847971520365;15806.051636901822;16206.432774852823;16430.67138657244;16633.750493742602;679934.6003269952;681951.5902420456;686562;687360;688889;55671.721641392345;55871.72064139653;55961;56087;56417.43582564204;1266.7459215376896;1285.6014635463036;1350.9256990865597;1379.7654398752436;1389.610908945497;18598.2560697576;29444.852775735984;29645.407091858473;30510.237244069074;31670.208244794063;54241.45758542364;54789.726051369486;54959.72520137374;54974.17538737002;54989;635582;637243;640711;642355;642659;39677.404838926865;40078.79960600295;40389;40496.392554111124;40532.79733601313;42856.78571607122;44214.557854421044;44470.3329450065;45552;46028.539714602426;37682;37860.43209351917;37898.43152352772;38168.80915595404;38246.043848904;37095.8145209283;37643.05892352713;38033.04336632354;38680.6131938677;38716.225675486894;36117;36347;36738.08154796044;36852;36905.81547092248;32480.83759581187;34200.31599368049;34343;34376.14059648529;34441.82779086089;24807.13175038865;25261.97904167699;25329.493410131327;25676.358091047125;25697.871510643075 08:02:20 INFO - PROCESS | 6438 | |2;jquery.html;351.2272999401317;359.15240033520905;379.16016024505717;384.2046962787032;398.73882606892477;17737.64524709505;18625.4412367629;18696.532586685324;19318.710219346704;19488.512787180327;10869.945650271737;11586.884131158686;11693.590724324651;11716.765664686702;11717.945384915356;4949.406071271453;5251.396089449705;5338.225957236198;5346.331708536433;5352.143657014878;3787.431885217212;3986.063275130342;5265.104932161542;5619.915701264485;5914.349421563625;5899.498542623882;5939.67331796751;5969.731362088694;5983.700814959257;5997.640141591497;5697.829065128053;5939.67331796751;5978.6711730855;5984.461398474158;5991.550633702446;4971.204607262856;5764.020116580192;5795.710214489259;5809.070548712186;5820.534357251409;23039.654405183937;23147.53704925892;23989.760102398926;24284.028638854426;24297.757022429727;1894.384325094336;2199.6480563109826;2337.1936681844736;2691.9192424227303;2834.4614523240725;9054.456732596065;9531;10010.399376037461;10044.598216071348;10052.944440833753;1790.9104544772708;1863.152265719108;1899.9525011874675;1935.7870634230223;1959.118396721481;95613;108439.45780271049;112085;114039.28941065891;126312;9104.180623743894;10462.947685261524;11089.05743011853;11143.888561114447;11570.76858462826;13190.934045329712;13507.189568625914;14550.708985820223;14571.92714036423;14580.270986450634;7484.738034168778;8183.95908020456;8192.098869124391;8466.830663386698;8570.700025499202;6838.623875686785;7268.854622907618;8247;8333.208345207195;8458.40791144614;4475.6643251755595;4515.864524064284;4532.116237333688;4538.546145385435;4595;1566.169929937135;1675.9413420530223;1678.430667326054;1908.8950107744208;1936.5158710322419;787.6180052674448;841.3605659698673;872.6953204958628;877.3858299190592;887.8668199769957;19320;20058.59882802365;20145.59708805845;20167.193312267344;20691;709.9396551293095;831.9126491718282;841.2512863551444;898.833715762586;913.5386629751932;10278.280520363653;10734.463276836126;10795.02844743961;10805.027547520604;10826.51280692355;585246;600594;603268.9836550789;621042;622815;128947;129674.70325296627;130629;131071.34464327617;131276;888.8977767556813;892.3931726425963;903.4714691905177;920.4109370003204;922.9723108306762;17794.93230406128;17822.287108516033;18167.091645417942;18226.817731822513;18234;55285.72357138189;55903.16145257906;55971;56909;57029.71485142548;77043.61478192573;78212.2178778205;78419;79569.60215198887;79711.60144199242;6057.848553786191;7116.644167791694;7222.241664625349;7317.5609463432365;7516.812079698051;9194.448333099768;12154.75690486203;12274.938625306817;12298.385080746106;12543.24740515572;10559.472026398804;10615.8938410618;10755.677329680122;10895.400752958663;11029.503672334924;10219.94890025575;10403.53184106732;10533.262671612914;10693.9465302673;10980.780384392427;10762.19283553721;10834.620788272372;10854.45727713627;11202.21584489078;11271.830922536004;7259.310365515267;7283.053203083565;7302.817429564091;7391.4086873048955;7457.403407727477;8121.106678265268;9870.555824987749;10602.522886469973;10973.890261097287;11031.22781405294 08:02:20 INFO - PROCESS | 6438 | |3;mootools.html;1457.9416823327065;1467.127059399657;1657.1631326180277;1677.9748303775439;1804.7834259888816;7489.887651685229;7718.498297610666;7986.720464783733;8437;8466.153384661531;7909.960450197756;8182.7545173644885;8229.423940324179;8286.088530261666;8294.502329860212;2320.106758897824;2328.324785812121;2347.9882600586975;2352.1179557665873;2353.5410594933996;2317.9420514487106;2360.079568968104;2372.2764556810166;2375.9168429104984;2382.404398900275;2203.2508946958033;2225.7551669316363;2232.531168454618;2240.025588868847;2252.042881775239;2288.420989517228;2307.180950762489;2325.5813953488364;2333.5099629077745;2342.6603142544323;2325.976740232593;2349.635806450003;2351.917682881091;2357.2221167014845;2363.031157225529;8297.543635100066;8312.8337433251;8333.458325208841;8333.541655208961;8375.078741338448;5008.5993120550265;5042.495750424965;5137.434882162959;5200.609954253446;5208.348956380452;3207.679232076797;3366.764326497146;3474.8957531274104;3508.0528257370624;3510;1006.9647562335283;1017.6387382479261;1076.4886678827572;1086.4893500054961;1089.0525243038528;10832.350058996486;10858.077063449617;10880.67357979262;10930.945345273223;10954.452277386179;4288.335308027198;4481.484629267611;4574.45106587205;4690.671652984258;4698.083873644607;8472.661093556311;9371.06289371071;9479.052094790604;9481.241500680067;9490;4986.152354099811;4990.575801056878;4994.4755800640405;4994.850154495371;4995.275685025651;4126.463559737215;4278.315469524861;4400.723790100835;4554.27131658933;4743.146233677971;3212.9678703213135;3815.6565909068318;3839.1170030892495;3890.16361482277;3898.90252743678;1250.4310538704867;1261.104615722847;1263.684078980255;1267.847858257015;1276.8786965238287;768.3699366519512;849.7280870121625;899.9010108888017;908.8773015642804;914.5838643417229;4780;5388.164834450667;5479.75341109651;5724.084146536534;5848.561357898175;884.2616415293302;890.1988210610502;891.0465801592363;895.5969813583783;923.9097864519931;3295.307985323061;3327.1515763480156;3789.412641040643;3825.101101241206;3903.434002069741;9706.660266890625;10001.2999090063;10056.798864022678;10077.69766906994;10170.186385089175;6773.45812335012;8710.998235202906;9864.408135511892;9935.751606209902;10050.798984020425;7346.742863999734;7745.186755390716;7758.650860711282;7773.144954055049;7797.376209903194;5340.839774806762;5434.5652347812875;5613.298337707786;5769.134629805562;5947.286325640951;8963.417377870417;9303.162715355651;9309.674161404319;9397.342186046912;9440.622375105193;8007.15924827908;9168.129027742354;9393;9507.809843802946;9522.381045232038;6144.539159562962;6281.843793082713;7057.682404291717;7106.289371063059;7216.7834964951135;7279.980802687734;7734.458587899018;7910.2089791020435;8010.91989080125;8029.277365037175;6999.8950015750825;7114.430845532448;7130.928690713026;7172.49792514519;7235.746748863765;7049.894251586128;7054.647267636495;7054.858902822018;7092.184398793998;7191.892121618284;6457.160569126171;6467;6551.737930482918;6557.606543607399;6571.948488241858;4887.60899128076;4915.6067514598035;4920.286558448934;4936.777844997056;4958.8760280993265;4530.932036019528;4551.180787458289;4574.702644328108;4700.600448961876;4750.812296925768 08:02:20 INFO - PROCESS | 6438 | |4;prototype.html;299.2190383100109;308.0972749842962;309.9256178517155;311.9719225269726;316.81624657698535;4135.586441355867;4937.2840938064;5190.429052804193;5230;5387.138057910735;4875.63432742544;5270.9736451317685;5311.521963023327;5411.242426060355;5450.645708028976;3350.7486938479587;4120.835166593332;4133.483314585676;4136.958630413687;4143.171365726852;3559.6796288334044;3956.9208615827665;4090.6727461802984;4153.6677065834665;4164.375343698454;3408.5398471206317;3763.5483741951;4132.4421203137645;4138.0482489027545;4142.544320124784;3746.9812650936706;3995.9610501269735;4140.68944829139;4148.7303325284065;4168.895777605554;3077.79994300372;3306.35526072416;3453.620101788801;3457.4640930655787;3614.5301110855685;4897.897972956056;4984.651074424755;5032.245163225509;5121.948780512222;5160.974195129001;4045.280755678825;4056;4195.328747400401;4305.935410968838;4551.590356867898;5669.886602267973;5689.146628005791;5779.450952159538;5799.3620701722775;5836.5622578306375;3384.5769278840144;3545.617209288354;3589.397686677164;3964;3965;5289.862679523882;6032.577719559633;6039.909401358983;6043.925854516227;6089.969550152266;4073.7575039613203;4087.4235044336206;4092.856750013735;4094.590540945941;4097.303458412077;3310.354480876206;3905.9218815624095;3947.250022495774;3970.50368703912;4098.7950602469755;3822.7897465639658;3922.5685174630767;4682.695624784378;4766.594839438687;4787.3776409066595;5059.709774007678;5511;5572.080606699849;5724.427557244326;5802.622829516068;1114.1922106472905;1269.6508460173527;1311.90816642836;1315.4606611289325;1326.9649673254876;838.4005436113208;920.59953920045;933.6078846884325;935.4714586258742;937.2548823685187;4209.936850947238;4414.933775993299;4749.627764287326;5067;5101.974490127525;5215.608829337815;5308.362996440452;5494.835154945358;5578.684845788952;5624.368933009463;4076.7146299758733;4208.537060923296;4863.7324947128245;5100.974495127501;5133.869444180697;2663.3753410420018;2796.734310240524;2892.5950366948646;2906.912792616225;2940.2068035366487;5712.7434663308595;5746.971265143731;5753.021986262345;5767.250257466587;5799.100449775113;4571.977140114344;4637.582617564435;5094.261332106824;5199.350081239845;5593.776248950077;4699.036697477009;4986.650934434555;5488.4785945335125;5776.624519406225;5828.504577110993;4628.9353448706315;4632.791524381479;5528.778848846162;5582.794796055617;5605.299337582802;5164.91536777281;5395.16564368101;5500.954818584456;5528.419515950767;5546.473085056913;4747.596454301423;5810.331811841692;5821.38875418075;5827.446392592697;5839.474447299764;3439.810810405452;3541.13242255649;3874.108954940323;3880.758157389608;3881.7282790205545;5459.481349271813;5545.306836645419;5617.736009398016;5649.830505084854;6062.696865156813;4437.489688685713;5703.515201207943;5824.970875145597;5863;5914.929774578863;5199.974000129975;5591.965486384869;5897.498712609477;5927.9922413189;5929.687421905546;4586.472555656009;5455.536279416136;5672.801451949162;5748.338941021836;5798.246227990334;5749.482546570829;5755.971220143872;5785.884282314246;5895.793647222326;5933.258342707161;4297.613214810682;4804.50165913716;5256.211568264791;5688.658680479184;5752.827415177551 08:02:20 INFO - PROCESS | 6438 | |5;yui.html;681.8090934538332;745.3515441565837;751.6805357722969;773.8374941262334;788.2590365056844;14619;15184.772228416583;15283.465078722247;15299.694006119871;15307.617309567266;11759.35323557204;13557.796633050511;13639.522616708417;13705.314734263296;13705.65735856604;782.8121250899786;793.8372633610124;801.5150833745558;804.047204063184;808.7007807111347;793.8332950080461;803.8432505661399;808.312934006096;809.380823669893;811.6225954930956;817.7546735979212;845.8223773007645;846.2003406780594;847.0386111763162;847.92792612628;678.9694463749094;741.4550305525435;816.8897198878135;828.6022709099636;832.0556168748484;559.5355854640638;623.0654018971543;627.4541149200224;628.5976974736172;629.5750368501289;10191.89808101917;12039.856213659776;12587.496500139983;12604.747905041848;12656.303903285316;9868.407895526292;10333.121684656813;11390.202685811997;11555.306681599131;11778.705532361673;10027.949860250725;10147.34042287249;10242.48787560619;10380.948095259551;10581.841272380843;3431.2108215110666;3526.347625689256;3570.4644303354444;3573.4103872860946;3654;59910.61818290019;60520.1843944678;64591.677041614494;73946.63026684886;95830.52084739531;10809.78380432387;10810.56757729682;10815.513301901434;10913.290636108628;11084.113270938306;21061.10450059502;21089.68365474519;21290;21303.78696213018;21310.36068917935;7555.886661700079;7570.318671319607;7673.194314596887;7910.604469776488;8048.59757012147;4182.498100227992;4218.029853133797;4251.3622956556765;4277.2087163874785;4293.763842988603;2964.184849166453;3370.410178218851;3496.667816557423;3503.8072905989907;3510.9122271943406;638.0078977190514;642.9776655118384;651.3909494622543;662.3674390956625;711.3526690711428;582.8251524542706;657.8421178917025;660.4353277947286;666.6866572710915;688.1088989758275;7274.125950976277;8956.462612243286;9072.54637268134;9251.629934802533;9447.811043779086;657.7138944559132;663.5288944849211;670.1187937861696;670.6445583840572;676.705633049625;4279.7218180818145;4388.539203383599;4390.912181756347;4419.712878507842;4526.456825181;107349.63251837376;110348;118930.4053479727;121227.78772212341;122375;105082.94917050884;105606.9439305597;106635;108848.4557577207;109986.80026399427;90342.54828725946;91707.54146229225;93381;94958;95014;8225.424220304521;8340.332773378237;8575.356848236283;8588.141185881363;8715.564221789013;34377.828110859286;41025.79487102546;49025;52015.73992130015;52420;50806.47580572589;74415.8837617447;75802;76451.61774191093;81712.59143704243;10629.627963021567;10692.449594808864;10713.410762407831;10770.569177233136;11040.944795276293;11823.940880295544;11853.407329633656;11869.465874035863;11957.641270761891;12419.503219871103;11103.444827758742;11169.72075698114;11248.26886252391;11409.201355905006;11637.53449861996;10984.626921634796;11611.825822612498;11627.244229125079;11672;12023.45894434735;10029.849552256575;11243.943780281046;11342.319460832376;11409.771804563696;11782.646520604396;9525.428474291564;9670.468124253233;9808.460534670661;9837.262205334771;9921.057499537532;9538;9690.37012594179;9749.36629119105;9759;9760.560774765294 08:02:20 INFO - PROCESS | 6438 | __end_tp_report 08:02:20 INFO - PROCESS | 6438 | __start_cc_report 08:02:20 INFO - PROCESS | 6438 | _x_x_mozilla_cycle_collect,374 08:02:20 INFO - PROCESS | 6438 | __end_cc_report 08:02:20 INFO - PROCESS | 6438 | __startTimestamp1482854540485__endTimestamp 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | ------- Summary: start ------- 08:02:20 INFO - PROCESS | 6438 | Number of tests: 6 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | [#0] dojo.html Cycles:165 Average:5679.37 Median:5847.97 stddev:675.09 (11.5%) stddev-sans-first:650.94 08:02:20 INFO - PROCESS | 6438 | Values: 3304.2 3318.2 3354.8 3362.6 3366.6 5598.4 5635.0 5658.3 5709.0 5720.8 5626.8 5762.5 5764.9 5768.7 5788.0 5185.7 5194.1 5227.8 5263.3 5276.9 5225.2 5290.8 5293.0 5313.5 5342.3 5072.4 5131.8 5226.8 5263.8 5279.4 4117.0 4223.5 4314.4 4562.6 5029.1 4562.0 5056.2 5085.4 5165.5 5232.3 5338.9 5576.1 5651.2 5727.9 5754.7 6143.2 6208.5 6220.2 6228.1 6237.8 6207.2 6238.2 6258.5 6265.5 6269.0 5660.4 5738.0 5750.4 5930.2 5935.2 6176.9 6185.7 6210.7 6235.8 6243.8 5170.8 6107.8 6117.3 6124.8 6141.5 5664.8 5810.7 6115.5 6208.3 6215.4 6063.8 6068.6 6130.0 6171.4 6181.5 6131.3 6153.8 6192.7 6192.8 6246.1 4854.2 4899.3 4902.7 4911.6 4930.0 4395.0 4428.4 4444.1 4473.1 4486.4 5496.1 5646.6 5683.9 5750.3 5756.9 6161.9 6170.1 6181.7 6239.4 6257.2 5781.5 5819.2 5824.1 5832.2 5863.9 5369.4 5381.1 5433.4 5444.2 5457.3 5195.2 6142.4 6192.5 6330.2 6380.1 6229.6 6254.4 6268.4 6296.6 6299.1 6373.9 6387.8 6412.0 6414.6 6449.7 5050.3 5880.0 6109.1 6216.3 6221.8 6147.9 6153.4 6169.1 6186.0 6234.6 6138.4 6163.1 6173.9 6197.3 6211.9 5968.4 6097.5 6146.7 6157.0 6177.3 5200.7 5237.9 5898.0 5903.4 6059.2 6107.5 6126.8 6132.7 6139.1 6148.9 5762.1 5794.0 5845.7 5848.0 5915.4 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | [#1] ext.html Cycles:180 Average:73025.42 Median:39487.01 stddev:163524.51 (414.1%) stddev-sans-first:163892.45 08:02:20 INFO - PROCESS | 6438 | Values: 450.1 459.5 479.0 481.3 550.7 26401.0 38771.8 38838.2 38925.4 39002.4 39296.6 39768.0 39808.4 39919.2 39943.2 9169.5 9393.8 9400.2 9411.2 9426.9 9201.8 9239.2 9298.0 9312.4 9344.1 9308.2 9323.3 9324.1 9330.0 9353.9 9222.3 9266.9 9271.9 9302.8 9306.8 7729.7 9119.1 9125.1 9129.9 9149.1 37766.4 37954.8 38005.8 38084.2 38175.4 3234.6 3245.3 3713.0 3828.3 3880.7 26176.6 27829.7 27918.2 30231.8 30475.1 2976.4 3079.1 3103.8 3196.9 3202.1 483001.0 488028.0 488484.0 493060.0 493214.0 59103.0 60011.0 60139.4 60160.4 60178.7 61607.4 62447.8 62485.7 62601.7 62775.0 15550.8 15759.2 16022.4 16033.4 16066.6 11968.0 12060.2 12062.7 12102.6 12109.9 18164.6 18300.7 18319.7 18320.9 18426.0 3108.3 6927.6 7113.9 7256.5 7512.4 847.5 970.6 991.7 993.1 1065.6 28779.9 29138.4 29217.0 29753.0 29836.7 838.6 999.9 1015.0 1034.2 1049.4 15202.8 15806.1 16206.4 16430.7 16633.8 679934.6 681951.6 686562.0 687360.0 688889.0 55671.7 55871.7 55961.0 56087.0 56417.4 1266.7 1285.6 1350.9 1379.8 1389.6 18598.3 29444.9 29645.4 30510.2 31670.2 54241.5 54789.7 54959.7 54974.2 54989.0 635582.0 637243.0 640711.0 642355.0 642659.0 39677.4 40078.8 40389.0 40496.4 40532.8 42856.8 44214.6 44470.3 45552.0 46028.5 37682.0 37860.4 37898.4 38168.8 38246.0 37095.8 37643.1 38033.0 38680.6 38716.2 36117.0 36347.0 36738.1 36852.0 36905.8 32480.8 34200.3 34343.0 34376.1 34441.8 24807.1 25262.0 25329.5 25676.4 25697.9 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | [#2] jquery.html Cycles:180 Average:34614.13 Median:2083.30 stddev:101268.41 (4861.0%) stddev-sans-first:101519.82 08:02:20 INFO - PROCESS | 6438 | Values: 351.2 359.2 379.2 384.2 398.7 17737.6 18625.4 18696.5 19318.7 19488.5 10869.9 11586.9 11693.6 11716.8 11717.9 4949.4 5251.4 5338.2 5346.3 5352.1 3787.4 3986.1 5265.1 5619.9 5914.3 5899.5 5939.7 5969.7 5983.7 5997.6 5697.8 5939.7 5978.7 5984.5 5991.6 4971.2 5764.0 5795.7 5809.1 5820.5 23039.7 23147.5 23989.8 24284.0 24297.8 1894.4 2199.6 2337.2 2691.9 2834.5 9054.5 9531.0 10010.4 10044.6 10052.9 1790.9 1863.2 1900.0 1935.8 1959.1 95613.0 108439.5 112085.0 114039.3 126312.0 9104.2 10462.9 11089.1 11143.9 11570.8 13190.9 13507.2 14550.7 14571.9 14580.3 7484.7 8184.0 8192.1 8466.8 8570.7 6838.6 7268.9 8247.0 8333.2 8458.4 4475.7 4515.9 4532.1 4538.5 4595.0 1566.2 1675.9 1678.4 1908.9 1936.5 787.6 841.4 872.7 877.4 887.9 19320.0 20058.6 20145.6 20167.2 20691.0 709.9 831.9 841.3 898.8 913.5 10278.3 10734.5 10795.0 10805.0 10826.5 585246.0 600594.0 603269.0 621042.0 622815.0 128947.0 129674.7 130629.0 131071.3 131276.0 888.9 892.4 903.5 920.4 923.0 17794.9 17822.3 18167.1 18226.8 18234.0 55285.7 55903.2 55971.0 56909.0 57029.7 77043.6 78212.2 78419.0 79569.6 79711.6 6057.8 7116.6 7222.2 7317.6 7516.8 9194.4 12154.8 12274.9 12298.4 12543.2 10559.5 10615.9 10755.7 10895.4 11029.5 10219.9 10403.5 10533.3 10693.9 10980.8 10762.2 10834.6 10854.5 11202.2 11271.8 7259.3 7283.1 7302.8 7391.4 7457.4 8121.1 9870.6 10602.5 10973.9 11031.2 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | [#3] mootools.html Cycles:180 Average:5358.17 Median:5001.94 stddev:2923.05 (58.4%) stddev-sans-first:2916.56 08:02:20 INFO - PROCESS | 6438 | Values: 1457.9 1467.1 1657.2 1678.0 1804.8 7489.9 7718.5 7986.7 8437.0 8466.2 7910.0 8182.8 8229.4 8286.1 8294.5 2320.1 2328.3 2348.0 2352.1 2353.5 2317.9 2360.1 2372.3 2375.9 2382.4 2203.3 2225.8 2232.5 2240.0 2252.0 2288.4 2307.2 2325.6 2333.5 2342.7 2326.0 2349.6 2351.9 2357.2 2363.0 8297.5 8312.8 8333.5 8333.5 8375.1 5008.6 5042.5 5137.4 5200.6 5208.3 3207.7 3366.8 3474.9 3508.1 3510.0 1007.0 1017.6 1076.5 1086.5 1089.1 10832.4 10858.1 10880.7 10930.9 10954.5 4288.3 4481.5 4574.5 4690.7 4698.1 8472.7 9371.1 9479.1 9481.2 9490.0 4986.2 4990.6 4994.5 4994.9 4995.3 4126.5 4278.3 4400.7 4554.3 4743.1 3213.0 3815.7 3839.1 3890.2 3898.9 1250.4 1261.1 1263.7 1267.8 1276.9 768.4 849.7 899.9 908.9 914.6 4780.0 5388.2 5479.8 5724.1 5848.6 884.3 890.2 891.0 895.6 923.9 3295.3 3327.2 3789.4 3825.1 3903.4 9706.7 10001.3 10056.8 10077.7 10170.2 6773.5 8711.0 9864.4 9935.8 10050.8 7346.7 7745.2 7758.7 7773.1 7797.4 5340.8 5434.6 5613.3 5769.1 5947.3 8963.4 9303.2 9309.7 9397.3 9440.6 8007.2 9168.1 9393.0 9507.8 9522.4 6144.5 6281.8 7057.7 7106.3 7216.8 7280.0 7734.5 7910.2 8010.9 8029.3 6999.9 7114.4 7130.9 7172.5 7235.7 7049.9 7054.6 7054.9 7092.2 7191.9 6457.2 6467.0 6551.7 6557.6 6571.9 4887.6 4915.6 4920.3 4936.8 4958.9 4530.9 4551.2 4574.7 4700.6 4750.8 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | [#4] prototype.html Cycles:180 Average:4489.71 Median:4985.65 stddev:1397.50 (28.0%) stddev-sans-first:1365.57 08:02:20 INFO - PROCESS | 6438 | Values: 299.2 308.1 309.9 312.0 316.8 4135.6 4937.3 5190.4 5230.0 5387.1 4875.6 5271.0 5311.5 5411.2 5450.6 3350.7 4120.8 4133.5 4137.0 4143.2 3559.7 3956.9 4090.7 4153.7 4164.4 3408.5 3763.5 4132.4 4138.0 4142.5 3747.0 3996.0 4140.7 4148.7 4168.9 3077.8 3306.4 3453.6 3457.5 3614.5 4897.9 4984.7 5032.2 5121.9 5161.0 4045.3 4056.0 4195.3 4305.9 4551.6 5669.9 5689.1 5779.5 5799.4 5836.6 3384.6 3545.6 3589.4 3964.0 3965.0 5289.9 6032.6 6039.9 6043.9 6090.0 4073.8 4087.4 4092.9 4094.6 4097.3 3310.4 3905.9 3947.3 3970.5 4098.8 3822.8 3922.6 4682.7 4766.6 4787.4 5059.7 5511.0 5572.1 5724.4 5802.6 1114.2 1269.7 1311.9 1315.5 1327.0 838.4 920.6 933.6 935.5 937.3 4209.9 4414.9 4749.6 5067.0 5102.0 5215.6 5308.4 5494.8 5578.7 5624.4 4076.7 4208.5 4863.7 5101.0 5133.9 2663.4 2796.7 2892.6 2906.9 2940.2 5712.7 5747.0 5753.0 5767.3 5799.1 4572.0 4637.6 5094.3 5199.4 5593.8 4699.0 4986.7 5488.5 5776.6 5828.5 4628.9 4632.8 5528.8 5582.8 5605.3 5164.9 5395.2 5501.0 5528.4 5546.5 4747.6 5810.3 5821.4 5827.4 5839.5 3439.8 3541.1 3874.1 3880.8 3881.7 5459.5 5545.3 5617.7 5649.8 6062.7 4437.5 5703.5 5825.0 5863.0 5914.9 5200.0 5592.0 5897.5 5928.0 5929.7 4586.5 5455.5 5672.8 5748.3 5798.2 5749.5 5756.0 5785.9 5895.8 5933.3 4297.6 4804.5 5256.2 5688.7 5752.8 08:02:20 INFO - PROCESS | 6438 | 08:02:20 INFO - PROCESS | 6438 | [#5] yui.html Cycles:180 Average:20059.87 Median:26775.73 stddev:30945.45 (115.6%) stddev-sans-first:30998.06 08:02:20 INFO - PROCESS | 6438 | Values: 681.8 745.4 751.7 773.8 788.3 14619.0 15184.8 15283.5 15299.7 15307.6 11759.4 13557.8 13639.5 13705.3 13705.7 782.8 793.8 801.5 804.0 808.7 793.8 803.8 808.3 809.4 811.6 817.8 845.8 846.2 847.0 847.9 679.0 741.5 816.9 828.6 832.1 559.5 623.1 627.5 628.6 629.6 10191.9 12039.9 12587.5 12604.7 12656.3 9868.4 10333.1 11390.2 11555.3 11778.7 10027.9 10147.3 10242.5 10380.9 10581.8 3431.2 3526.3 3570.5 3573.4 3654.0 59910.6 60520.2 64591.7 73946.6 95830.5 10809.8 10810.6 10815.5 10913.3 11084.1 21061.1 21089.7 21290.0 21303.8 21310.4 7555.9 7570.3 7673.2 7910.6 8048.6 4182.5 4218.0 4251.4 4277.2 4293.8 2964.2 3370.4 3496.7 3503.8 3510.9 638.0 643.0 651.4 662.4 711.4 582.8 657.8 660.4 666.7 688.1 7274.1 8956.5 9072.5 9251.6 9447.8 657.7 663.5 670.1 670.6 676.7 4279.7 4388.5 4390.9 4419.7 4526.5 107349.6 110348.0 118930.4 121227.8 122375.0 105082.9 105606.9 106635.0 108848.5 109986.8 90342.5 91707.5 93381.0 94958.0 95014.0 8225.4 8340.3 8575.4 8588.1 8715.6 34377.8 41025.8 49025.0 52015.7 52420.0 50806.5 74415.9 75802.0 76451.6 81712.6 10629.6 10692.4 10713.4 10770.6 11040.9 11823.9 11853.4 11869.5 11957.6 12419.5 11103.4 11169.7 11248.3 11409.2 11637.5 10984.6 11611.8 11627.2 11672.0 12023.5 10029.8 11243.9 11342.3 11409.8 11782.6 9525.4 9670.5 9808.5 9837.3 9921.1 9538.0 9690.4 9749.4 9759.0 9760.6 08:02:20 INFO - PROCESS | 6438 | -------- Summary: end -------- 08:02:20 INFO - PROCESS | 6438 | 08:02:21 INFO - TEST-INFO | 6438: exit 0 08:02:21 INFO - TEST-OK | dromaeo_css | took 1117195ms 08:02:21 INFO - TEST-START | kraken 08:02:21 INFO - operating with platform_type : mac_ 08:02:21 INFO - Initialising browser for kraken test... 08:02:21 INFO - TEST-INFO | started process 6443 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmph0EV0p/profile http://localhost:57461/getInfo.html) 08:02:23 INFO - PROCESS | 6443 | 2016-12-27 08:02:23.996 plugin-container[6444:123812] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464f, name = 'com.apple.tsm.portname' 08:02:23 INFO - PROCESS | 6443 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:02:24 INFO - PROCESS | 6443 | 2016-12-27 08:02:24.000 plugin-container[6444:123812] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:02:24 INFO - PROCESS | 6443 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:02:24 INFO - PROCESS | 6443 | 2016-12-27 08:02:24.000 plugin-container[6444:123812] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:02:24 INFO - PROCESS | 6443 | __metrics Screen width/height:1600/1200 08:02:24 INFO - PROCESS | 6443 | colorDepth:24 08:02:24 INFO - PROCESS | 6443 | Browser inner width/height: 1024/689 08:02:24 INFO - PROCESS | 6443 | __metrics 08:02:24 ERROR - PROCESS | 6443 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:02:25 INFO - TEST-INFO | 6443: exit 0 08:02:25 INFO - Browser initialized. 08:02:25 INFO - Running cycle 1/1 for kraken test... 08:02:25 INFO - TEST-INFO | started process 6445 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmph0EV0p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:27 INFO - PROCESS | 6445 | 2016-12-27 08:02:27.770 plugin-container[6446:123937] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x842b, name = 'com.apple.tsm.portname' 08:02:27 INFO - PROCESS | 6445 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:02:27 INFO - PROCESS | 6445 | 2016-12-27 08:02:27.771 plugin-container[6446:123937] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 08:02:27 INFO - PROCESS | 6445 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:02:27 INFO - PROCESS | 6445 | 2016-12-27 08:02:27.771 plugin-container[6446:123937] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:02:37 INFO - PROCESS | 6445 | RSS: Main: 229593088 08:02:37 INFO - PROCESS | 6445 | 08:02:40 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57461/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:41 INFO - PROCESS | 6445 | RSS: Main: 241401856 08:02:41 INFO - PROCESS | 6445 | 08:02:43 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57461/tests/kraken/driver.html?testName=audio-dft) 08:02:44 INFO - PROCESS | 6445 | RSS: Main: 249139200 08:02:44 INFO - PROCESS | 6445 | 08:02:47 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57461/tests/kraken/driver.html?testName=audio-fft) 08:02:48 INFO - PROCESS | 6445 | RSS: Main: 252919808 08:02:48 INFO - PROCESS | 6445 | 08:02:50 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57461/tests/kraken/driver.html?testName=audio-oscillator) 08:02:50 INFO - PROCESS | 6445 | RSS: Main: 253227008 08:02:50 INFO - PROCESS | 6445 | 08:02:53 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57461/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:53 INFO - PROCESS | 6445 | RSS: Main: 254394368 08:02:53 INFO - PROCESS | 6445 | 08:02:56 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57461/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:57 INFO - PROCESS | 6445 | RSS: Main: 258564096 08:02:57 INFO - PROCESS | 6445 | 08:03:00 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57461/tests/kraken/driver.html?testName=imaging-desaturate) 08:03:01 INFO - PROCESS | 6445 | RSS: Main: 258183168 08:03:01 INFO - PROCESS | 6445 | 08:03:04 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57461/tests/kraken/driver.html?testName=json-parse-financial) 08:03:05 INFO - PROCESS | 6445 | RSS: Main: 258265088 08:03:05 INFO - PROCESS | 6445 | 08:03:06 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57461/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:07 INFO - PROCESS | 6445 | RSS: Main: 257507328 08:03:07 INFO - PROCESS | 6445 | 08:03:09 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:09 INFO - PROCESS | 6445 | RSS: Main: 257486848 08:03:09 INFO - PROCESS | 6445 | 08:03:11 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:12 INFO - PROCESS | 6445 | RSS: Main: 257536000 08:03:12 INFO - PROCESS | 6445 | 08:03:15 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:16 INFO - PROCESS | 6445 | RSS: Main: 257794048 08:03:16 INFO - PROCESS | 6445 | 08:03:19 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:19 INFO - PROCESS | 6445 | RSS: Main: 257626112 08:03:19 INFO - PROCESS | 6445 | 08:03:21 INFO - PROCESS | 6445 | Cycle 1(1): loaded http://localhost:57461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57461/tests/kraken/driver.html?testName=ai-astar) 08:03:22 INFO - PROCESS | 6445 | RSS: Main: 259330048 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | __start_tp_report 08:03:22 INFO - PROCESS | 6445 | _x_x_mozilla_page_load 08:03:22 INFO - PROCESS | 6445 | _x_x_mozilla_page_load_details 08:03:22 INFO - PROCESS | 6445 | |i|pagename|runs| 08:03:22 INFO - PROCESS | 6445 | |0;ai-astar;108;118;117;121;119;120;121;120;119;122 08:03:22 INFO - PROCESS | 6445 | |1;audio-beat-detection;148;121;111;145;111;114;113;116;140;112 08:03:22 INFO - PROCESS | 6445 | |2;audio-dft;194;270;208;202;198;203;195;196;198;197 08:03:22 INFO - PROCESS | 6445 | |3;audio-fft;85;59;59;87;61;60;59;60;79;58 08:03:22 INFO - PROCESS | 6445 | |4;audio-oscillator;83;71;90;77;61;71;107;99;100;120 08:03:22 INFO - PROCESS | 6445 | |5;imaging-gaussian-blur;76;106;108;106;135;130;94;88;132;87 08:03:22 INFO - PROCESS | 6445 | |6;imaging-darkroom;111;173;110;130;118;108;171;170;119;170 08:03:22 INFO - PROCESS | 6445 | |7;imaging-desaturate;88;114;139;114;88;88;91;108;113;92 08:03:22 INFO - PROCESS | 6445 | |8;json-parse-financial;58;59;57;61;62;62;62;60;60;62 08:03:22 INFO - PROCESS | 6445 | |9;json-stringify-tinderbox;73;73;75;76;71;70;71;72;74;73 08:03:22 INFO - PROCESS | 6445 | |10;stanford-crypto-aes;86;85;86;96;90;78;72;75;76;81 08:03:22 INFO - PROCESS | 6445 | |11;stanford-crypto-ccm;151;154;150;155;149;164;161;157;213;187 08:03:22 INFO - PROCESS | 6445 | |12;stanford-crypto-pbkdf2;165;170;164;166;172;230;168;173;172;173 08:03:22 INFO - PROCESS | 6445 | |13;stanford-crypto-sha256-iterative;76;76;66;59;86;87;86;88;77;67 08:03:22 INFO - PROCESS | 6445 | __end_tp_report 08:03:22 INFO - PROCESS | 6445 | __start_cc_report 08:03:22 INFO - PROCESS | 6445 | _x_x_mozilla_cycle_collect,981 08:03:22 INFO - PROCESS | 6445 | __end_cc_report 08:03:22 INFO - PROCESS | 6445 | __startTimestamp1482854602004__endTimestamp 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | ------- Summary: start ------- 08:03:22 INFO - PROCESS | 6445 | Number of tests: 14 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#0] ai-astar Cycles:10 Average:118.50 Median:120.00 stddev:3.98 (3.3%) stddev-sans-first:1.58 08:03:22 INFO - PROCESS | 6445 | Values: 108.0 118.0 117.0 121.0 119.0 120.0 121.0 120.0 119.0 122.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:118.50 stddev:15.06 (12.7%) stddev-sans-first:13.00 08:03:22 INFO - PROCESS | 6445 | Values: 148.0 121.0 111.0 145.0 111.0 114.0 113.0 116.0 140.0 112.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#2] audio-dft Cycles:10 Average:206.10 Median:200.00 stddev:22.85 (11.4%) stddev-sans-first:23.81 08:03:22 INFO - PROCESS | 6445 | Values: 194.0 270.0 208.0 202.0 198.0 203.0 195.0 196.0 198.0 197.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#3] audio-fft Cycles:10 Average:66.70 Median:60.50 stddev:11.90 (19.7%) stddev-sans-first:10.62 08:03:22 INFO - PROCESS | 6445 | Values: 85.0 59.0 59.0 87.0 61.0 60.0 59.0 60.0 79.0 58.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:74.00 stddev:18.58 (25.1%) stddev-sans-first:19.62 08:03:22 INFO - PROCESS | 6445 | Values: 83.0 71.0 90.0 77.0 61.0 71.0 107.0 99.0 100.0 120.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#5] imaging-gaussian-blur Cycles:10 Average:106.20 Median:105.50 stddev:20.62 (19.5%) stddev-sans-first:18.75 08:03:22 INFO - PROCESS | 6445 | Values: 76.0 106.0 108.0 106.0 135.0 130.0 94.0 88.0 132.0 87.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#6] imaging-darkroom Cycles:10 Average:138.00 Median:150.00 stddev:29.06 (19.4%) stddev-sans-first:29.13 08:03:22 INFO - PROCESS | 6445 | Values: 111.0 173.0 110.0 130.0 118.0 108.0 171.0 170.0 119.0 170.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:88.00 stddev:17.00 (19.3%) stddev-sans-first:17.08 08:03:22 INFO - PROCESS | 6445 | Values: 88.0 114.0 139.0 114.0 88.0 88.0 91.0 108.0 113.0 92.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:61.50 stddev:1.83 (3.0%) stddev-sans-first:1.74 08:03:22 INFO - PROCESS | 6445 | Values: 58.0 59.0 57.0 61.0 62.0 62.0 62.0 60.0 60.0 62.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:73.00 stddev:1.87 (2.6%) stddev-sans-first:1.99 08:03:22 INFO - PROCESS | 6445 | Values: 73.0 73.0 75.0 76.0 71.0 70.0 71.0 72.0 74.0 73.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:85.50 stddev:7.46 (8.7%) stddev-sans-first:7.80 08:03:22 INFO - PROCESS | 6445 | Values: 86.0 85.0 86.0 96.0 90.0 78.0 72.0 75.0 76.0 81.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#11] stanford-crypto-ccm Cycles:10 Average:164.10 Median:159.00 stddev:20.44 (12.9%) stddev-sans-first:21.12 08:03:22 INFO - PROCESS | 6445 | Values: 151.0 154.0 150.0 155.0 149.0 164.0 161.0 157.0 213.0 187.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:172.00 stddev:19.51 (11.3%) stddev-sans-first:20.34 08:03:22 INFO - PROCESS | 6445 | Values: 165.0 170.0 164.0 166.0 172.0 230.0 168.0 173.0 172.0 173.0 08:03:22 INFO - PROCESS | 6445 | 08:03:22 INFO - PROCESS | 6445 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:81.50 stddev:10.16 (12.5%) stddev-sans-first:10.78 08:03:22 INFO - PROCESS | 6445 | Values: 76.0 76.0 66.0 59.0 86.0 87.0 86.0 88.0 77.0 67.0 08:03:22 INFO - PROCESS | 6445 | -------- Summary: end -------- 08:03:22 INFO - PROCESS | 6445 | 08:03:23 INFO - TEST-INFO | 6445: exit 0 08:03:23 INFO - TEST-OK | kraken | took 61941ms 08:03:23 INFO - SUITE-END | took 1179s 08:03:23 INFO - Completed test suite (00:19:39) 08:03:23 INFO - javascript benchmark 08:03:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7057.099584953318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.1574398528373, 3318.170457385654, 3354.815485148316, 3362.630110687824, 3366.6128395234555, 5598.356189038257, 5635.042042852715, 5658.292713410824, 5708.971455142719, 5720.8283751487415, 5626.831195064155, 5762.481376676098, 5764.942350576493, 5768.740406681699, 5787.958167529843, 5185.662931909433, 5194.117000109972, 5227.7908883644795, 5263.26314315996, 5276.92084618731, 5225.163973764198, 5290.841274761763, 5293.0, 5313.521783039526, 5342.305500284977, 5072.416672082721, 5131.794728210904, 5226.817061402851, 5263.842084737464, 5279.366476022863, 4117.032497363117, 4223.514295855985, 4314.374415709736, 4562.6121779648765, 5029.1450453423, 4561.977190114061, 5056.165732654108, 5085.415177254626, 5165.509276618753, 5232.293640358541, 5338.893222135535, 5576.079946808772, 5651.1523271509195, 5727.856803579903, 5754.74103665336, 6143.174139895654, 6208.50331973441, 6220.222472190976, 6228.096925945712, 6237.750489980395, 6207.224096987877, 6238.1578486904145, 6258.4680302174365, 6265.530085243625, 6269.0, 5660.377358490563, 5738.0, 5750.396208398141, 5930.229070220887, 5935.228420305376, 6176.8764624707255, 6185.721642526097, 6210.72051757672, 6235.750569977241, 6243.75024999004, 5170.819021334235, 6107.795737660903, 6117.327094019654, 6124.838682352551, 6141.477974372139, 5664.830055098354, 5810.738516766755, 6115.480184184395, 6208.286047104551, 6215.409536094064, 6063.818085457443, 6068.6358818471035, 6130.0, 6171.382861713882, 6181.505479561624, 6131.284916201153, 6153.8461538461, 6192.659403732838, 6192.845178870474, 6246.125542424064, 4854.2233242681, 4899.265110233422, 4902.730349830722, 4911.631627627942, 4930.0, 4395.033092719596, 4428.446444194476, 4444.11117776446, 4473.083017981306, 4486.371907932892, 5496.120620700669, 5646.632968857011, 5683.8863222736145, 5750.338711048199, 5756.856078598069, 6161.890859645307, 6170.10533472644, 6181.721822517998, 6239.407256310643, 6257.155284036688, 5781.479666830005, 5819.185314056035, 5824.126381042877, 5832.1834943108, 5863.882722345615, 5369.382521010056, 5381.0852155133725, 5433.429489903582, 5444.156155795858, 5457.263269458573, 5195.19474481456, 6142.406692085091, 6192.535559833121, 6330.208723909512, 6380.1067850501895, 6229.595076320024, 6254.374562543891, 6268.435840774352, 6296.590721603081, 6299.055141728777, 6373.864755307024, 6387.808365749035, 6412.03819427071, 6414.647194404352, 6449.7420103195345, 5050.267711181931, 5879.970600146972, 6109.131392048963, 6216.285127210429, 6221.844453888508, 6147.893379191788, 6153.4154255345675, 6169.074638804215, 6186.041163619646, 6234.625922444668, 6138.386161383826, 6163.106349579376, 6173.938260617337, 6197.349278325892, 6211.937880621136, 5968.373320801427, 6097.542684298606, 6146.692665366803, 6156.969215153896, 6177.2587289525545, 5200.699825043739, 5237.921431178459, 5897.970510147422, 5903.439173278532, 6059.182010428536, 6107.46191531438, 6126.846828829315, 6132.6920582337325, 6139.079138129317, 6148.907766383419, 5762.135679648086, 5794.0439827428, 5845.678487683218, 5847.970760146342, 5915.438033386821], "value": 5635.174844714215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.14023215658096, 459.4647235970095, 478.98084076636934, 481.29970892351633, 550.6833570696848, 26401.0, 38771.80614096929, 38838.223235535304, 38925.41611875817, 39002.414963775496, 39296.60703392965, 39768.0, 39808.40287395691, 39919.201615967664, 39943.201135977266, 9169.541522923844, 9393.765155871124, 9400.24798016157, 9411.200047995928, 9426.905730942672, 9201.815963680723, 9239.168474837263, 9298.0, 9312.441253524776, 9344.06559344067, 9308.208802251816, 9323.30075244356, 9324.06759324069, 9329.95335023324, 9353.859692104625, 9222.262219022463, 9266.860997085048, 9271.907280927171, 9302.813943721088, 9306.813863722755, 7729.652165652559, 9119.133682300171, 9125.133112354315, 9129.908700912973, 9149.085091490864, 37766.43350349747, 37954.81022594897, 38005.80997095024, 38084.23831523354, 38175.427368589495, 3234.5633339499336, 3245.269814291789, 3712.9814350928073, 3828.3109040372724, 3880.6701430378453, 26176.560289184086, 27829.721702783118, 27918.162455126378, 30231.848840755876, 30475.085747427613, 2976.4344774492993, 3079.0916679579354, 3103.798253113563, 3196.888108916177, 3202.1194171602997, 483001.0, 488028.0, 488484.0, 493060.0, 493214.0, 59103.0, 60011.0, 60139.39860601338, 60160.39839601635, 60178.69910650419, 61607.38392616017, 62447.751044979756, 62485.68757156276, 62601.74796504044, 62775.0, 15550.844491555166, 15759.212039398213, 16022.397760223885, 16033.358665653242, 16066.598335041484, 11968.0, 12060.21608595456, 12062.698432539257, 12102.636920892388, 12109.939450302869, 18164.63670726578, 18300.725489117674, 18319.725204121947, 18320.908395457936, 18426.0, 3108.3006323577465, 6927.618980955995, 7113.857722845618, 7256.492045556761, 7512.39900807934, 847.4533925618065, 970.6166064404521, 991.6628346362127, 993.1378665003119, 1065.6347670784435, 28779.856100719782, 29138.417231655247, 29216.97740579112, 29753.0, 29836.701632983826, 838.6310023589601, 999.9400035997863, 1015.0458568945168, 1034.2191645307744, 1049.4228174503992, 15202.847971520365, 15806.051636901822, 16206.432774852823, 16430.67138657244, 16633.750493742602, 679934.6003269952, 681951.5902420456, 686562.0, 687360.0, 688889.0, 55671.721641392345, 55871.72064139653, 55961.0, 56087.0, 56417.43582564204, 1266.7459215376896, 1285.6014635463036, 1350.9256990865597, 1379.7654398752436, 1389.610908945497, 18598.2560697576, 29444.852775735984, 29645.407091858473, 30510.237244069074, 31670.208244794063, 54241.45758542364, 54789.726051369486, 54959.72520137374, 54974.17538737002, 54989.0, 635582.0, 637243.0, 640711.0, 642355.0, 642659.0, 39677.404838926865, 40078.79960600295, 40389.0, 40496.392554111124, 40532.79733601313, 42856.78571607122, 44214.557854421044, 44470.3329450065, 45552.0, 46028.539714602426, 37682.0, 37860.43209351917, 37898.43152352772, 38168.80915595404, 38246.043848904, 37095.8145209283, 37643.05892352713, 38033.04336632354, 38680.6131938677, 38716.225675486894, 36117.0, 36347.0, 36738.08154796044, 36852.0, 36905.81547092248, 32480.83759581187, 34200.31599368049, 34343.0, 34376.14059648529, 34441.82779086089, 24807.13175038865, 25261.97904167699, 25329.493410131327, 25676.358091047125, 25697.871510643075], "value": 19741.077729498196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2272999401317, 359.15240033520905, 379.16016024505717, 384.2046962787032, 398.73882606892477, 17737.64524709505, 18625.4412367629, 18696.532586685324, 19318.710219346704, 19488.512787180327, 10869.945650271737, 11586.884131158686, 11693.590724324651, 11716.765664686702, 11717.945384915356, 4949.406071271453, 5251.396089449705, 5338.225957236198, 5346.331708536433, 5352.143657014878, 3787.431885217212, 3986.063275130342, 5265.104932161542, 5619.915701264485, 5914.349421563625, 5899.498542623882, 5939.67331796751, 5969.731362088694, 5983.700814959257, 5997.640141591497, 5697.829065128053, 5939.67331796751, 5978.6711730855, 5984.461398474158, 5991.550633702446, 4971.204607262856, 5764.020116580192, 5795.710214489259, 5809.070548712186, 5820.534357251409, 23039.654405183937, 23147.53704925892, 23989.760102398926, 24284.028638854426, 24297.757022429727, 1894.384325094336, 2199.6480563109826, 2337.1936681844736, 2691.9192424227303, 2834.4614523240725, 9054.456732596065, 9531.0, 10010.399376037461, 10044.598216071348, 10052.944440833753, 1790.9104544772708, 1863.152265719108, 1899.9525011874675, 1935.7870634230223, 1959.118396721481, 95613.0, 108439.45780271049, 112085.0, 114039.28941065891, 126312.0, 9104.180623743894, 10462.947685261524, 11089.05743011853, 11143.888561114447, 11570.76858462826, 13190.934045329712, 13507.189568625914, 14550.708985820223, 14571.92714036423, 14580.270986450634, 7484.738034168778, 8183.95908020456, 8192.098869124391, 8466.830663386698, 8570.700025499202, 6838.623875686785, 7268.854622907618, 8247.0, 8333.208345207195, 8458.40791144614, 4475.6643251755595, 4515.864524064284, 4532.116237333688, 4538.546145385435, 4595.0, 1566.169929937135, 1675.9413420530223, 1678.430667326054, 1908.8950107744208, 1936.5158710322419, 787.6180052674448, 841.3605659698673, 872.6953204958628, 877.3858299190592, 887.8668199769957, 19320.0, 20058.59882802365, 20145.59708805845, 20167.193312267344, 20691.0, 709.9396551293095, 831.9126491718282, 841.2512863551444, 898.833715762586, 913.5386629751932, 10278.280520363653, 10734.463276836126, 10795.02844743961, 10805.027547520604, 10826.51280692355, 585246.0, 600594.0, 603268.9836550789, 621042.0, 622815.0, 128947.0, 129674.70325296627, 130629.0, 131071.34464327617, 131276.0, 888.8977767556813, 892.3931726425963, 903.4714691905177, 920.4109370003204, 922.9723108306762, 17794.93230406128, 17822.287108516033, 18167.091645417942, 18226.817731822513, 18234.0, 55285.72357138189, 55903.16145257906, 55971.0, 56909.0, 57029.71485142548, 77043.61478192573, 78212.2178778205, 78419.0, 79569.60215198887, 79711.60144199242, 6057.848553786191, 7116.644167791694, 7222.241664625349, 7317.5609463432365, 7516.812079698051, 9194.448333099768, 12154.75690486203, 12274.938625306817, 12298.385080746106, 12543.24740515572, 10559.472026398804, 10615.8938410618, 10755.677329680122, 10895.400752958663, 11029.503672334924, 10219.94890025575, 10403.53184106732, 10533.262671612914, 10693.9465302673, 10980.780384392427, 10762.19283553721, 10834.620788272372, 10854.45727713627, 11202.21584489078, 11271.830922536004, 7259.310365515267, 7283.053203083565, 7302.817429564091, 7391.4086873048955, 7457.403407727477, 8121.106678265268, 9870.555824987749, 10602.522886469973, 10973.890261097287, 11031.22781405294], "value": 9025.277566640983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.9416823327065, 1467.127059399657, 1657.1631326180277, 1677.9748303775439, 1804.7834259888816, 7489.887651685229, 7718.498297610666, 7986.720464783733, 8437.0, 8466.153384661531, 7909.960450197756, 8182.7545173644885, 8229.423940324179, 8286.088530261666, 8294.502329860212, 2320.106758897824, 2328.324785812121, 2347.9882600586975, 2352.1179557665873, 2353.5410594933996, 2317.9420514487106, 2360.079568968104, 2372.2764556810166, 2375.9168429104984, 2382.404398900275, 2203.2508946958033, 2225.7551669316363, 2232.531168454618, 2240.025588868847, 2252.042881775239, 2288.420989517228, 2307.180950762489, 2325.5813953488364, 2333.5099629077745, 2342.6603142544323, 2325.976740232593, 2349.635806450003, 2351.917682881091, 2357.2221167014845, 2363.031157225529, 8297.543635100066, 8312.8337433251, 8333.458325208841, 8333.541655208961, 8375.078741338448, 5008.5993120550265, 5042.495750424965, 5137.434882162959, 5200.609954253446, 5208.348956380452, 3207.679232076797, 3366.764326497146, 3474.8957531274104, 3508.0528257370624, 3510.0, 1006.9647562335283, 1017.6387382479261, 1076.4886678827572, 1086.4893500054961, 1089.0525243038528, 10832.350058996486, 10858.077063449617, 10880.67357979262, 10930.945345273223, 10954.452277386179, 4288.335308027198, 4481.484629267611, 4574.45106587205, 4690.671652984258, 4698.083873644607, 8472.661093556311, 9371.06289371071, 9479.052094790604, 9481.241500680067, 9490.0, 4986.152354099811, 4990.575801056878, 4994.4755800640405, 4994.850154495371, 4995.275685025651, 4126.463559737215, 4278.315469524861, 4400.723790100835, 4554.27131658933, 4743.146233677971, 3212.9678703213135, 3815.6565909068318, 3839.1170030892495, 3890.16361482277, 3898.90252743678, 1250.4310538704867, 1261.104615722847, 1263.684078980255, 1267.847858257015, 1276.8786965238287, 768.3699366519512, 849.7280870121625, 899.9010108888017, 908.8773015642804, 914.5838643417229, 4780.0, 5388.164834450667, 5479.75341109651, 5724.084146536534, 5848.561357898175, 884.2616415293302, 890.1988210610502, 891.0465801592363, 895.5969813583783, 923.9097864519931, 3295.307985323061, 3327.1515763480156, 3789.412641040643, 3825.101101241206, 3903.434002069741, 9706.660266890625, 10001.2999090063, 10056.798864022678, 10077.69766906994, 10170.186385089175, 6773.45812335012, 8710.998235202906, 9864.408135511892, 9935.751606209902, 10050.798984020425, 7346.742863999734, 7745.186755390716, 7758.650860711282, 7773.144954055049, 7797.376209903194, 5340.839774806762, 5434.5652347812875, 5613.298337707786, 5769.134629805562, 5947.286325640951, 8963.417377870417, 9303.162715355651, 9309.674161404319, 9397.342186046912, 9440.622375105193, 8007.15924827908, 9168.129027742354, 9393.0, 9507.809843802946, 9522.381045232038, 6144.539159562962, 6281.843793082713, 7057.682404291717, 7106.289371063059, 7216.7834964951135, 7279.980802687734, 7734.458587899018, 7910.2089791020435, 8010.91989080125, 8029.277365037175, 6999.8950015750825, 7114.430845532448, 7130.928690713026, 7172.49792514519, 7235.746748863765, 7049.894251586128, 7054.647267636495, 7054.858902822018, 7092.184398793998, 7191.892121618284, 6457.160569126171, 6467.0, 6551.737930482918, 6557.606543607399, 6571.948488241858, 4887.60899128076, 4915.6067514598035, 4920.286558448934, 4936.777844997056, 4958.8760280993265, 4530.932036019528, 4551.180787458289, 4574.702644328108, 4700.600448961876, 4750.812296925768], "value": 4360.388657337499, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2190383100109, 308.0972749842962, 309.9256178517155, 311.9719225269726, 316.81624657698535, 4135.586441355867, 4937.2840938064, 5190.429052804193, 5230.0, 5387.138057910735, 4875.63432742544, 5270.9736451317685, 5311.521963023327, 5411.242426060355, 5450.645708028976, 3350.7486938479587, 4120.835166593332, 4133.483314585676, 4136.958630413687, 4143.171365726852, 3559.6796288334044, 3956.9208615827665, 4090.6727461802984, 4153.6677065834665, 4164.375343698454, 3408.5398471206317, 3763.5483741951, 4132.4421203137645, 4138.0482489027545, 4142.544320124784, 3746.9812650936706, 3995.9610501269735, 4140.68944829139, 4148.7303325284065, 4168.895777605554, 3077.79994300372, 3306.35526072416, 3453.620101788801, 3457.4640930655787, 3614.5301110855685, 4897.897972956056, 4984.651074424755, 5032.245163225509, 5121.948780512222, 5160.974195129001, 4045.280755678825, 4056.0, 4195.328747400401, 4305.935410968838, 4551.590356867898, 5669.886602267973, 5689.146628005791, 5779.450952159538, 5799.3620701722775, 5836.5622578306375, 3384.5769278840144, 3545.617209288354, 3589.397686677164, 3964.0, 3965.0, 5289.862679523882, 6032.577719559633, 6039.909401358983, 6043.925854516227, 6089.969550152266, 4073.7575039613203, 4087.4235044336206, 4092.856750013735, 4094.590540945941, 4097.303458412077, 3310.354480876206, 3905.9218815624095, 3947.250022495774, 3970.50368703912, 4098.7950602469755, 3822.7897465639658, 3922.5685174630767, 4682.695624784378, 4766.594839438687, 4787.3776409066595, 5059.709774007678, 5511.0, 5572.080606699849, 5724.427557244326, 5802.622829516068, 1114.1922106472905, 1269.6508460173527, 1311.90816642836, 1315.4606611289325, 1326.9649673254876, 838.4005436113208, 920.59953920045, 933.6078846884325, 935.4714586258742, 937.2548823685187, 4209.936850947238, 4414.933775993299, 4749.627764287326, 5067.0, 5101.974490127525, 5215.608829337815, 5308.362996440452, 5494.835154945358, 5578.684845788952, 5624.368933009463, 4076.7146299758733, 4208.537060923296, 4863.7324947128245, 5100.974495127501, 5133.869444180697, 2663.3753410420018, 2796.734310240524, 2892.5950366948646, 2906.912792616225, 2940.2068035366487, 5712.7434663308595, 5746.971265143731, 5753.021986262345, 5767.250257466587, 5799.100449775113, 4571.977140114344, 4637.582617564435, 5094.261332106824, 5199.350081239845, 5593.776248950077, 4699.036697477009, 4986.650934434555, 5488.4785945335125, 5776.624519406225, 5828.504577110993, 4628.9353448706315, 4632.791524381479, 5528.778848846162, 5582.794796055617, 5605.299337582802, 5164.91536777281, 5395.16564368101, 5500.954818584456, 5528.419515950767, 5546.473085056913, 4747.596454301423, 5810.331811841692, 5821.38875418075, 5827.446392592697, 5839.474447299764, 3439.810810405452, 3541.13242255649, 3874.108954940323, 3880.758157389608, 3881.7282790205545, 5459.481349271813, 5545.306836645419, 5617.736009398016, 5649.830505084854, 6062.696865156813, 4437.489688685713, 5703.515201207943, 5824.970875145597, 5863.0, 5914.929774578863, 5199.974000129975, 5591.965486384869, 5897.498712609477, 5927.9922413189, 5929.687421905546, 4586.472555656009, 5455.536279416136, 5672.801451949162, 5748.338941021836, 5798.246227990334, 5749.482546570829, 5755.971220143872, 5785.884282314246, 5895.793647222326, 5933.258342707161, 4297.613214810682, 4804.50165913716, 5256.211568264791, 5688.658680479184, 5752.827415177551], "value": 4050.876977844851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.8090934538332, 745.3515441565837, 751.6805357722969, 773.8374941262334, 788.2590365056844, 14619.0, 15184.772228416583, 15283.465078722247, 15299.694006119871, 15307.617309567266, 11759.35323557204, 13557.796633050511, 13639.522616708417, 13705.314734263296, 13705.65735856604, 782.8121250899786, 793.8372633610124, 801.5150833745558, 804.047204063184, 808.7007807111347, 793.8332950080461, 803.8432505661399, 808.312934006096, 809.380823669893, 811.6225954930956, 817.7546735979212, 845.8223773007645, 846.2003406780594, 847.0386111763162, 847.92792612628, 678.9694463749094, 741.4550305525435, 816.8897198878135, 828.6022709099636, 832.0556168748484, 559.5355854640638, 623.0654018971543, 627.4541149200224, 628.5976974736172, 629.5750368501289, 10191.89808101917, 12039.856213659776, 12587.496500139983, 12604.747905041848, 12656.303903285316, 9868.407895526292, 10333.121684656813, 11390.202685811997, 11555.306681599131, 11778.705532361673, 10027.949860250725, 10147.34042287249, 10242.48787560619, 10380.948095259551, 10581.841272380843, 3431.2108215110666, 3526.347625689256, 3570.4644303354444, 3573.4103872860946, 3654.0, 59910.61818290019, 60520.1843944678, 64591.677041614494, 73946.63026684886, 95830.52084739531, 10809.78380432387, 10810.56757729682, 10815.513301901434, 10913.290636108628, 11084.113270938306, 21061.10450059502, 21089.68365474519, 21290.0, 21303.78696213018, 21310.36068917935, 7555.886661700079, 7570.318671319607, 7673.194314596887, 7910.604469776488, 8048.59757012147, 4182.498100227992, 4218.029853133797, 4251.3622956556765, 4277.2087163874785, 4293.763842988603, 2964.184849166453, 3370.410178218851, 3496.667816557423, 3503.8072905989907, 3510.9122271943406, 638.0078977190514, 642.9776655118384, 651.3909494622543, 662.3674390956625, 711.3526690711428, 582.8251524542706, 657.8421178917025, 660.4353277947286, 666.6866572710915, 688.1088989758275, 7274.125950976277, 8956.462612243286, 9072.54637268134, 9251.629934802533, 9447.811043779086, 657.7138944559132, 663.5288944849211, 670.1187937861696, 670.6445583840572, 676.705633049625, 4279.7218180818145, 4388.539203383599, 4390.912181756347, 4419.712878507842, 4526.456825181, 107349.63251837376, 110348.0, 118930.4053479727, 121227.78772212341, 122375.0, 105082.94917050884, 105606.9439305597, 106635.0, 108848.4557577207, 109986.80026399427, 90342.54828725946, 91707.54146229225, 93381.0, 94958.0, 95014.0, 8225.424220304521, 8340.332773378237, 8575.356848236283, 8588.141185881363, 8715.564221789013, 34377.828110859286, 41025.79487102546, 49025.0, 52015.73992130015, 52420.0, 50806.47580572589, 74415.8837617447, 75802.0, 76451.61774191093, 81712.59143704243, 10629.627963021567, 10692.449594808864, 10713.410762407831, 10770.569177233136, 11040.944795276293, 11823.940880295544, 11853.407329633656, 11869.465874035863, 11957.641270761891, 12419.503219871103, 11103.444827758742, 11169.72075698114, 11248.26886252391, 11409.201355905006, 11637.53449861996, 10984.626921634796, 11611.825822612498, 11627.244229125079, 11672.0, 12023.45894434735, 10029.849552256575, 11243.943780281046, 11342.319460832376, 11409.771804563696, 11782.646520604396, 9525.428474291564, 9670.468124253233, 9808.460534670661, 9837.262205334771, 9921.057499537532, 9538.0, 9690.37012594179, 9749.36629119105, 9759.0, 9760.560774765294], "value": 6964.617942575232, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 117.0, 121.0, 119.0, 120.0, 121.0, 120.0, 119.0, 122.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 111.0, 145.0, 111.0, 114.0, 113.0, 116.0, 140.0, 112.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 270.0, 208.0, 202.0, 198.0, 203.0, 195.0, 196.0, 198.0, 197.0], "value": 206.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 59.0, 87.0, 61.0, 60.0, 59.0, 60.0, 79.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 90.0, 77.0, 61.0, 71.0, 107.0, 99.0, 100.0, 120.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 106.0, 108.0, 106.0, 135.0, 130.0, 94.0, 88.0, 132.0, 87.0], "value": 106.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 173.0, 110.0, 130.0, 118.0, 108.0, 171.0, 170.0, 119.0, 170.0], "value": 138.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 114.0, 139.0, 114.0, 88.0, 88.0, 91.0, 108.0, 113.0, 92.0], "value": 103.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 61.0, 62.0, 62.0, 62.0, 60.0, 60.0, 62.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 76.0, 71.0, 70.0, 71.0, 72.0, 74.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 96.0, 90.0, 78.0, 72.0, 75.0, 76.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 154.0, 150.0, 155.0, 149.0, 164.0, 161.0, 157.0, 213.0, 187.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 164.0, 166.0, 172.0, 230.0, 168.0, 173.0, 172.0, 173.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 66.0, 59.0, 86.0, 87.0, 86.0, 88.0, 77.0, 67.0], "value": 76.8, "unit": "score"}]}]} 08:03:23 INFO - Return code: 0 08:03:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:23 ERROR - # TBPL SUCCESS # 08:03:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:23 INFO - 2016-12-27 08:03:23.343 screenresolution[6450:124322] starting screenresolution argv=screenresolution get 08:03:23 INFO - 2016-12-27 08:03:23.347 screenresolution[6450:124322] Display 0: 1600x1200x32@60 08:03:23 INFO - 2016-12-27 08:03:23.353 screenresolution[6451:124325] starting screenresolution argv=screenresolution list 08:03:23 INFO - Available Modes on Display 0 08:03:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:23 INFO - Intel Iris: 08:03:23 INFO - Chipset Model: Intel Iris 08:03:23 INFO - Type: GPU 08:03:23 INFO - Bus: Built-In 08:03:23 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:23 INFO - Vendor: Intel (0x8086) 08:03:23 INFO - Device ID: 0x0a2e 08:03:23 INFO - Revision ID: 0x0009 08:03:23 INFO - Displays: 08:03:23 INFO - Display: 08:03:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:23 INFO - Display Serial Number: 1600x1200 60 08:03:23 INFO - Main Display: Yes 08:03:23 INFO - Mirror: Off 08:03:23 INFO - Online: Yes 08:03:23 INFO - Rotation: Supported 08:03:23 INFO - Return code: 0 08:03:23 INFO - Running post-action listener: _resource_record_post_action 08:03:23 INFO - [mozharness: 2016-12-27 16:03:23.592232Z] Finished run-tests step (success) 08:03:23 INFO - Running post-run listener: _resource_record_post_run 08:03:23 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 1596416; Write bytes: 663819264; Read time: 22; Write time: 2092 08:03:23 INFO - TinderboxPrint: CPU usage
54.4% 08:03:23 INFO - TinderboxPrint: I/O read bytes / time
1,596,416 / 22 08:03:23 INFO - TinderboxPrint: I/O write bytes / time
663,819,264 / 2,092 08:03:23 INFO - TinderboxPrint: CPU idle
2,209.3 (45.6%) 08:03:23 INFO - TinderboxPrint: CPU system
978.7 (20.2%) 08:03:23 INFO - TinderboxPrint: CPU user
1,657.7 (34.2%) 08:03:23 INFO - TinderboxPrint: Swap in / out
351,137,792 / 0 08:03:23 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 346032640; Write bytes: 345094144; Read time: 26809; Write time: 654 08:03:23 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1555456; Write bytes: 309892608; Read time: 21; Write time: 1364 08:03:24 INFO - Running post-run listener: _upload_blobber_files 08:03:24 INFO - Blob upload gear active. 08:03:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:24 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 08:03:24 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'] 08:03:24 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 08:03:24 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:03:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:03:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:25 INFO - (blobuploader) - INFO - Done attempting. 08:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:26 INFO - (blobuploader) - INFO - Done attempting. 08:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:28 INFO - (blobuploader) - INFO - Done attempting. 08:03:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:28 INFO - Return code: 0 08:03:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf01e49b0b7135da1f844bb2ab8732f80b239bd177892237029144a235b6714d3bf8badea2d737fee474adaf9aac3d95e02d91a699b846106b5cbe94d7f3302a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8202f6b2303c73aae8c0257faaa8da46d7a4397c6e9615f9dfac49ab4e6f5960c95949120b720c09b0c73fa4fe7fe9f676ab528047eb96e3f0dee8fc2b5e01ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0572e5d6c06f3ecc147f56cd540697f9305e67a6e03c3e60c9507a0e230d63c64ecfd183c14e2b04ceac73c1a68949a084738b33d2b6da98352c28b77791a6b"} 08:03:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:28 INFO - Contents: 08:03:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf01e49b0b7135da1f844bb2ab8732f80b239bd177892237029144a235b6714d3bf8badea2d737fee474adaf9aac3d95e02d91a699b846106b5cbe94d7f3302a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8202f6b2303c73aae8c0257faaa8da46d7a4397c6e9615f9dfac49ab4e6f5960c95949120b720c09b0c73fa4fe7fe9f676ab528047eb96e3f0dee8fc2b5e01ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0572e5d6c06f3ecc147f56cd540697f9305e67a6e03c3e60c9507a0e230d63c64ecfd183c14e2b04ceac73c1a68949a084738b33d2b6da98352c28b77791a6b"} 08:03:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:28 INFO - Copying logs to upload dir... 08:03:28 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.954596 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-27 08:03:28.966603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:28.972404) ========= 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.EjqozAzxDq/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.mmJpomwjVV/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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/bf01e49b0b7135da1f844bb2ab8732f80b239bd177892237029144a235b6714d3bf8badea2d737fee474adaf9aac3d95e02d91a699b846106b5cbe94d7f3302a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8202f6b2303c73aae8c0257faaa8da46d7a4397c6e9615f9dfac49ab4e6f5960c95949120b720c09b0c73fa4fe7fe9f676ab528047eb96e3f0dee8fc2b5e01ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0572e5d6c06f3ecc147f56cd540697f9305e67a6e03c3e60c9507a0e230d63c64ecfd183c14e2b04ceac73c1a68949a084738b33d2b6da98352c28b77791a6b"} build_url:https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/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/bf01e49b0b7135da1f844bb2ab8732f80b239bd177892237029144a235b6714d3bf8badea2d737fee474adaf9aac3d95e02d91a699b846106b5cbe94d7f3302a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8202f6b2303c73aae8c0257faaa8da46d7a4397c6e9615f9dfac49ab4e6f5960c95949120b720c09b0c73fa4fe7fe9f676ab528047eb96e3f0dee8fc2b5e01ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0572e5d6c06f3ecc147f56cd540697f9305e67a6e03c3e60c9507a0e230d63c64ecfd183c14e2b04ceac73c1a68949a084738b33d2b6da98352c28b77791a6b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:29.016830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:29.017171) ========= 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.EjqozAzxDq/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.mmJpomwjVV/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005376 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:29.068915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 08:03:29.069290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 08:03:29.071113) ========= ========= Total master_lag: 0.23 =========