builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0269 starttime: 1480246080.33 results: success (0) buildid: 20161127004009 builduid: d46ad0142a954e418fbb0f2d287d35ff revision: fe8d7e54713a87a4a356a77ff35b0830a8567e76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.331514) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.331986) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.332275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.356859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.357161) ========= 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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-27 03:28:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 54.0M=0s 2016-11-27 03:28:00 (54.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.479975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.860007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.860291) ========= 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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.019263 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:00.908419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 03:28:00.908731) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fe8d7e54713a87a4a356a77ff35b0830a8567e76 --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 fe8d7e54713a87a4a356a77ff35b0830a8567e76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TnIRJBFy0w/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.2ORDJrtsnW/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-27 03:28:00,990 truncating revision to first 12 chars 2016-11-27 03:28:00,990 Setting DEBUG logging. 2016-11-27 03:28:00,990 attempt 1/10 2016-11-27 03:28:00,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fe8d7e54713a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-27 03:28:02,088 unpacking tar archive at: mozilla-aurora-fe8d7e54713a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.356526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-27 03:28:02.288624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:02.288897) ========= script_repo_revision: fe8d7e54713a87a4a356a77ff35b0830a8567e76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:02.289283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:02.289551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-27 03:28:02.311117) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-27 03:28:02.311397) ========= /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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:02 INFO - MultiFileLogger online at 20161127 03:28:02 in /builds/slave/test 03:28:02 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 03:28:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:02 INFO - {'append_to_log': False, 03:28:02 INFO - 'base_work_dir': '/builds/slave/test', 03:28:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:28:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:02 INFO - 'branch': 'Mozilla-Aurora', 03:28:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:02 INFO - 'config_files': ('talos/mac_config.py',), 03:28:02 INFO - 'default_actions': ('clobber', 03:28:02 INFO - 'read-buildbot-config', 03:28:02 INFO - 'download-and-extract', 03:28:02 INFO - 'populate-webroot', 03:28:02 INFO - 'create-virtualenv', 03:28:02 INFO - 'install', 03:28:02 INFO - 'run-tests'), 03:28:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:02 INFO - 'download_minidump_stackwalk': True, 03:28:02 INFO - 'download_symbols': 'ondemand', 03:28:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:02 INFO - 'installer_path': 'installer.exe', 03:28:02 INFO - 'log_level': 'info', 03:28:02 INFO - 'log_name': 'talos', 03:28:02 INFO - 'log_to_console': True, 03:28:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:28:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:28:02 INFO - 'opt_config_files': (), 03:28:02 INFO - 'pip_index': False, 03:28:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:28:02 INFO - 'cmd': ('bash', 03:28:02 INFO - '-c', 03:28:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:28:02 INFO - 'enabled': True, 03:28:02 INFO - 'halt_on_failure': False, 03:28:02 INFO - 'name': 'check_screen_resolution'},), 03:28:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:28:02 INFO - 'cmd': ('bash', 03:28:02 INFO - '-c', 03:28:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:28:02 INFO - 'enabled': True, 03:28:02 INFO - 'halt_on_failure': False, 03:28:02 INFO - 'name': 'check_screen_resolution'},), 03:28:02 INFO - 'run_cmd_checks_enabled': True, 03:28:02 INFO - 'sps_profile': False, 03:28:02 INFO - 'sps_profile_interval': 0, 03:28:02 INFO - 'suite': 'dromaeojs-e10s', 03:28:02 INFO - 'system_bits': '32', 03:28:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:02 INFO - 'title': 't-yosemite-r7-0269', 03:28:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:02 INFO - 'use_talos_json': True, 03:28:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:02 INFO - 'work_dir': 'build'} 03:28:02 INFO - [mozharness: 2016-11-27 11:28:02.511742Z] Running clobber step. 03:28:02 INFO - Running pre-action listener: _resource_record_pre_action 03:28:02 INFO - Running main action method: clobber 03:28:02 INFO - rmtree: /builds/slave/test/build 03:28:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - [mozharness: 2016-11-27 11:28:04.023711Z] Finished clobber step (success) 03:28:04 INFO - [mozharness: 2016-11-27 11:28:04.023850Z] Running read-buildbot-config step. 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: read_buildbot_config 03:28:04 INFO - Using buildbot properties: 03:28:04 INFO - { 03:28:04 INFO - "project": "", 03:28:04 INFO - "product": "firefox", 03:28:04 INFO - "script_repo_revision": "production", 03:28:04 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:28:04 INFO - "repository": "", 03:28:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:28:04 INFO - "buildid": "20161127004009", 03:28:04 INFO - "stage_platform": "macosx64", 03:28:04 INFO - "basedir": "/builds/slave/test", 03:28:04 INFO - "nightly_build": "True", 03:28:04 INFO - "buildnumber": 33, 03:28:04 INFO - "slavename": "t-yosemite-r7-0269", 03:28:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:28:04 INFO - "platform": "yosemite_r7", 03:28:04 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:28:04 INFO - "branch": "mozilla-aurora", 03:28:04 INFO - "repo_path": "releases/mozilla-aurora", 03:28:04 INFO - "revision": "fe8d7e54713a87a4a356a77ff35b0830a8567e76", 03:28:04 INFO - "pgo_build": "False", 03:28:04 INFO - "builduid": "d46ad0142a954e418fbb0f2d287d35ff", 03:28:04 INFO - "slavebuilddir": "test" 03:28:04 INFO - } 03:28:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - [mozharness: 2016-11-27 11:28:04.027381Z] Finished read-buildbot-config step (success) 03:28:04 INFO - [mozharness: 2016-11-27 11:28:04.027443Z] Running download-and-extract step. 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: download_and_extract 03:28:04 INFO - mkdir: /builds/slave/test/build/tests 03:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:04 INFO - trying https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/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 03:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/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 03:28:05 INFO - Downloaded 1199 bytes. 03:28:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:28:05 INFO - Using the following test package requirements: 03:28:05 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:28:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:28:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:28:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'jsshell-mac.zip'], 03:28:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:28:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:28:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:28:05 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:28:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:28:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:28:05 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:28:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:28:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:28:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:28:05 INFO - Fetch https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:28:06 INFO - Http code: 200 03:28:06 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 03:28:06 INFO - x-amz-cf-id: clECnyIn2_ZgaLb8-GaVLV9O5u31QpZ6RhZJnL4ZhbeZ3f7bLdeNUQ== 03:28:06 INFO - x-amz-version-id: HU7donbX_b3SA5j3aAJoGYdvJJnWGAuI 03:28:06 INFO - Expected file size: 16279127 03:28:06 INFO - Obtained file size: 16279127 03:28:13 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 03:28:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:28:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:28:13 INFO - Fetch https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:28:13 INFO - Http code: 200 03:28:13 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 03:28:13 INFO - x-amz-cf-id: Z_cogu6iZhZQ7veqAI3tsuF4FLK_jDz0d5YfpNcUXZ9AR0zXguIzuQ== 03:28:13 INFO - x-amz-version-id: HU7donbX_b3SA5j3aAJoGYdvJJnWGAuI 03:28:14 INFO - Expected file size: 16279127 03:28:14 INFO - Obtained file size: 16279127 03:28:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:28:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:28:20 INFO - Fetch https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:28:21 INFO - Http code: 200 03:28:21 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 03:28:21 INFO - x-amz-cf-id: kle5g7Rk1IbTckXjuDYeCF3e1F1CwbVp_5whgE5gRkxxuO9oV8H-bA== 03:28:21 INFO - x-amz-version-id: GaQGdspDzNnFG9cu.N51EceDQVVjg_CN 03:28:21 INFO - Expected file size: 14409038 03:28:21 INFO - Obtained file size: 14409038 03:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:21 INFO - trying https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:28:21 INFO - Downloading https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/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 03:28:25 INFO - Downloaded 109747689 bytes. 03:28:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:28:25 INFO - mkdir: /builds/slave/test/properties 03:28:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:25 INFO - Contents: 03:28:25 INFO - build_url:https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:28:26 INFO - Running post-action listener: _resource_record_post_action 03:28:26 INFO - Running post-action listener: set_extra_try_arguments 03:28:26 INFO - [mozharness: 2016-11-27 11:28:26.432289Z] Finished download-and-extract step (success) 03:28:26 INFO - [mozharness: 2016-11-27 11:28:26.432425Z] Running populate-webroot step. 03:28:26 INFO - Running pre-action listener: _resource_record_pre_action 03:28:26 INFO - Running main action method: populate_webroot 03:28:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:26 INFO - '--tppagecycles', 03:28:26 INFO - '7'], 03:28:26 INFO - 'tests': ['tsvgm']}}, 03:28:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['damp', 'tps']}, 03:28:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'tests': ['damp', 'tps']}, 03:28:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['dromaeo_dom']}, 03:28:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['basic_compositor_video']}, 03:28:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:28:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['a11yr', 03:28:26 INFO - 'ts_paint', 03:28:26 INFO - 'tpaint', 03:28:26 INFO - 'sessionrestore', 03:28:26 INFO - 'sessionrestore_no_auto_restore', 03:28:26 INFO - 'tabpaint']}, 03:28:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:26 INFO - 'ts_paint', 03:28:26 INFO - 'tpaint', 03:28:26 INFO - 'sessionrestore', 03:28:26 INFO - 'sessionrestore_no_auto_restore', 03:28:26 INFO - 'tabpaint']}, 03:28:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:26 INFO - 'ts_paint', 03:28:26 INFO - 'tpaint', 03:28:26 INFO - 'sessionrestore', 03:28:26 INFO - 'sessionrestore_no_auto_restore', 03:28:26 INFO - 'tabpaint']}, 03:28:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:26 INFO - 'ts_paint', 03:28:26 INFO - 'tpaint', 03:28:26 INFO - 'sessionrestore', 03:28:26 INFO - 'sessionrestore_no_auto_restore', 03:28:26 INFO - 'tabpaint']}, 03:28:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['a11yr', 03:28:26 INFO - 'ts_paint', 03:28:26 INFO - 'tpaint', 03:28:26 INFO - 'sessionrestore', 03:28:26 INFO - 'sessionrestore_no_auto_restore', 03:28:26 INFO - 'tabpaint']}, 03:28:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['a11yr', 03:28:26 INFO - 'ts_paint', 03:28:26 INFO - 'tpaint', 03:28:26 INFO - 'sessionrestore', 03:28:26 INFO - 'sessionrestore_no_auto_restore', 03:28:26 INFO - 'tabpaint']}, 03:28:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['tsvgx', 03:28:26 INFO - 'tsvgr_opacity', 03:28:26 INFO - 'tart', 03:28:26 INFO - 'tscrollx', 03:28:26 INFO - 'cart']}, 03:28:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:26 INFO - 'tsvgr_opacity', 03:28:26 INFO - 'tart', 03:28:26 INFO - 'tscrollx', 03:28:26 INFO - 'cart']}, 03:28:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'talos_options': ['--disable-e10s'], 03:28:26 INFO - 'tests': ['tp5o']}, 03:28:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'tests': ['tp5o']}, 03:28:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'talos_options': ['--disable-e10s', 03:28:26 INFO - '--xperf_path', 03:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:26 INFO - 'tests': ['tp5n']}, 03:28:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:26 INFO - 'talos_options': ['--xperf_path', 03:28:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:26 INFO - 'tests': ['tp5n']}}, 03:28:26 INFO - 'talos.zip': {'path': '', 03:28:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:26 INFO - Running post-action listener: _resource_record_post_action 03:28:26 INFO - [mozharness: 2016-11-27 11:28:26.451372Z] Finished populate-webroot step (success) 03:28:26 INFO - [mozharness: 2016-11-27 11:28:26.451508Z] Running create-virtualenv step. 03:28:26 INFO - Running pre-action listener: _resource_record_pre_action 03:28:26 INFO - Running main action method: create_virtualenv 03:28:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:26 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 03:28:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:26 INFO - Using real prefix '/tools/python27' 03:28:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:30 INFO - Installing pip.................done. 03:28:30 INFO - Return code: 0 03:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:30 INFO - Reading from file tmpfile_stdout 03:28:30 INFO - Output received: 03:28:30 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) 03:28:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:30 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 03:28:30 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 03:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:30 INFO - 'HOME': '/Users/cltbld', 03:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:30 INFO - 'LOGNAME': 'cltbld', 03:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:30 INFO - 'MOZ_NO_REMOTE': '1', 03:28:30 INFO - 'NO_EM_RESTART': '1', 03:28:30 INFO - 'PAGER': '/bin/cat', 03:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:30 INFO - 'PWD': '/builds/slave/test', 03:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:30 INFO - 'SHELL': '/bin/bash', 03:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:30 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:30 INFO - 'USER': 'cltbld', 03:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:30 INFO - 'XPC_FLAGS': '0x0', 03:28:30 INFO - 'XPC_SERVICE_NAME': '0', 03:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:30 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 03:28:30 INFO - Cleaning up... 03:28:30 INFO - Return code: 0 03:28:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:30 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:30 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 03:28:30 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 03:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:30 INFO - 'HOME': '/Users/cltbld', 03:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:30 INFO - 'LOGNAME': 'cltbld', 03:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:30 INFO - 'MOZ_NO_REMOTE': '1', 03:28:30 INFO - 'NO_EM_RESTART': '1', 03:28:30 INFO - 'PAGER': '/bin/cat', 03:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:30 INFO - 'PWD': '/builds/slave/test', 03:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:30 INFO - 'SHELL': '/bin/bash', 03:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:30 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:30 INFO - 'USER': 'cltbld', 03:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:30 INFO - 'XPC_FLAGS': '0x0', 03:28:30 INFO - 'XPC_SERVICE_NAME': '0', 03:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:30 INFO - Downloading/unpacking psutil>=3.1.1 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:34 INFO - Installing collected packages: psutil 03:28:34 INFO - Running setup.py install for psutil 03:28:34 INFO - building 'psutil._psutil_osx' extension 03:28:34 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 INFO - building 'psutil._psutil_posix' extension 03:28:35 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 03:28:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:28:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:28:35 INFO - ^ 03:28:35 INFO - 1 warning generated. 03:28:35 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 03:28:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:35 INFO - Successfully installed psutil 03:28:35 INFO - Cleaning up... 03:28:35 INFO - Return code: 0 03:28:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:35 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')]} 03:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:35 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')]} 03:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:35 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:35 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 03:28:35 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 03:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:35 INFO - 'HOME': '/Users/cltbld', 03:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:35 INFO - 'LOGNAME': 'cltbld', 03:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:35 INFO - 'MOZ_NO_REMOTE': '1', 03:28:35 INFO - 'NO_EM_RESTART': '1', 03:28:35 INFO - 'PAGER': '/bin/cat', 03:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:35 INFO - 'PWD': '/builds/slave/test', 03:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:35 INFO - 'SHELL': '/bin/bash', 03:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:35 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:35 INFO - 'USER': 'cltbld', 03:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:35 INFO - 'XPC_FLAGS': '0x0', 03:28:35 INFO - 'XPC_SERVICE_NAME': '0', 03:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:35 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 03:28:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:38 INFO - Installing collected packages: mozsystemmonitor 03:28:38 INFO - Running setup.py install for mozsystemmonitor 03:28:38 INFO - Successfully installed mozsystemmonitor 03:28:38 INFO - Cleaning up... 03:28:38 INFO - Return code: 0 03:28:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:38 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')]} 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 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')]} 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:38 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 03:28:38 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 03:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:38 INFO - 'HOME': '/Users/cltbld', 03:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:38 INFO - 'LOGNAME': 'cltbld', 03:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:38 INFO - 'MOZ_NO_REMOTE': '1', 03:28:38 INFO - 'NO_EM_RESTART': '1', 03:28:38 INFO - 'PAGER': '/bin/cat', 03:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:38 INFO - 'PWD': '/builds/slave/test', 03:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:38 INFO - 'SHELL': '/bin/bash', 03:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:38 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:38 INFO - 'USER': 'cltbld', 03:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:38 INFO - 'XPC_FLAGS': '0x0', 03:28:38 INFO - 'XPC_SERVICE_NAME': '0', 03:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:39 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 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:41 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 03:28:41 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 03:28:41 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 03:28:41 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 03:28:41 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 03:28:41 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 03:28:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:41 INFO - warning: no files found matching '*.txt' 03:28:41 INFO - no previously-included directories found matching 'build' 03:28:41 INFO - no previously-included directories found matching 'dist' 03:28:41 INFO - no previously-included directories found matching '.git*' 03:28:41 INFO - Installing collected packages: jsonschema, functools32 03:28:42 INFO - Running setup.py install for functools32 03:28:42 INFO - warning: no files found matching '*.txt' 03:28:42 INFO - no previously-included directories found matching 'build' 03:28:42 INFO - no previously-included directories found matching 'dist' 03:28:42 INFO - no previously-included directories found matching '.git*' 03:28:42 INFO - Successfully installed jsonschema functools32 03:28:42 INFO - Cleaning up... 03:28:42 INFO - Return code: 0 03:28:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:42 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')]} 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:42 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')]} 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:42 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:42 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 03:28:42 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 03:28:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:42 INFO - 'HOME': '/Users/cltbld', 03:28:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:42 INFO - 'LOGNAME': 'cltbld', 03:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:42 INFO - 'MOZ_NO_REMOTE': '1', 03:28:42 INFO - 'NO_EM_RESTART': '1', 03:28:42 INFO - 'PAGER': '/bin/cat', 03:28:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:42 INFO - 'PWD': '/builds/slave/test', 03:28:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:42 INFO - 'SHELL': '/bin/bash', 03:28:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:42 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:42 INFO - 'USER': 'cltbld', 03:28:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:42 INFO - 'XPC_FLAGS': '0x0', 03:28:42 INFO - 'XPC_SERVICE_NAME': '0', 03:28:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:42 INFO - Cleaning up... 03:28:42 INFO - Return code: 0 03:28:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:42 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')]} 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:42 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')]} 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:42 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:42 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 03:28:42 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 03:28:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:42 INFO - 'HOME': '/Users/cltbld', 03:28:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:42 INFO - 'LOGNAME': 'cltbld', 03:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:42 INFO - 'MOZ_NO_REMOTE': '1', 03:28:42 INFO - 'NO_EM_RESTART': '1', 03:28:42 INFO - 'PAGER': '/bin/cat', 03:28:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:42 INFO - 'PWD': '/builds/slave/test', 03:28:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:42 INFO - 'SHELL': '/bin/bash', 03:28:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:42 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:42 INFO - 'USER': 'cltbld', 03:28:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:42 INFO - 'XPC_FLAGS': '0x0', 03:28:42 INFO - 'XPC_SERVICE_NAME': '0', 03:28:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:45 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 03:28:45 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 03:28:45 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 03:28:45 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 03:28:45 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 03:28:45 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 03:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 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 03:28:46 INFO - Downloading docopt-0.6.1.tar.gz 03:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:46 INFO - Running setup.py install for blobuploader 03:28:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:46 INFO - Running setup.py install for requests 03:28:47 INFO - Running setup.py install for docopt 03:28:47 INFO - Successfully installed blobuploader requests docopt 03:28:47 INFO - Cleaning up... 03:28:47 INFO - Return code: 0 03:28:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:47 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:47 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 03:28:47 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 03:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:47 INFO - 'HOME': '/Users/cltbld', 03:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:47 INFO - 'LOGNAME': 'cltbld', 03:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:47 INFO - 'MOZ_NO_REMOTE': '1', 03:28:47 INFO - 'NO_EM_RESTART': '1', 03:28:47 INFO - 'PAGER': '/bin/cat', 03:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:47 INFO - 'PWD': '/builds/slave/test', 03:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:47 INFO - 'SHELL': '/bin/bash', 03:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:47 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:47 INFO - 'USER': 'cltbld', 03:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:47 INFO - 'XPC_FLAGS': '0x0', 03:28:47 INFO - 'XPC_SERVICE_NAME': '0', 03:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-TPFA3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-J8FdSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-TpsIxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-AIh9dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-T4r1GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Vskwpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-iNoLBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-jYxhn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-qNneHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-J4QjrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-K850we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_i0TZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:49 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-752UB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:49 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-2Vf2Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:49 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-GshFoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:49 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-p10p1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:49 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-o0rQdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:49 INFO - Running setup.py install for manifestparser 03:28:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:49 INFO - Running setup.py install for mozcrash 03:28:49 INFO - Running setup.py install for mozdebug 03:28:50 INFO - Running setup.py install for mozdevice 03:28:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Running setup.py install for mozfile 03:28:50 INFO - Running setup.py install for mozhttpd 03:28:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Running setup.py install for mozinfo 03:28:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Running setup.py install for mozInstall 03:28:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:50 INFO - Running setup.py install for mozleak 03:28:50 INFO - Running setup.py install for mozlog 03:28:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Running setup.py install for moznetwork 03:28:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Running setup.py install for mozprocess 03:28:51 INFO - Running setup.py install for mozprofile 03:28:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Running setup.py install for mozrunner 03:28:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Running setup.py install for mozscreenshot 03:28:51 INFO - Running setup.py install for moztest 03:28:52 INFO - Running setup.py install for mozversion 03:28:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:52 INFO - Cleaning up... 03:28:52 INFO - Return code: 0 03:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:52 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:52 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 03:28:52 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 03:28:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:52 INFO - 'HOME': '/Users/cltbld', 03:28:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:52 INFO - 'LOGNAME': 'cltbld', 03:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:52 INFO - 'MOZ_NO_REMOTE': '1', 03:28:52 INFO - 'NO_EM_RESTART': '1', 03:28:52 INFO - 'PAGER': '/bin/cat', 03:28:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:52 INFO - 'PWD': '/builds/slave/test', 03:28:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:52 INFO - 'SHELL': '/bin/bash', 03:28:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:52 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:52 INFO - 'USER': 'cltbld', 03:28:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:52 INFO - 'XPC_FLAGS': '0x0', 03:28:52 INFO - 'XPC_SERVICE_NAME': '0', 03:28:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ek0hal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:52 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)) 03:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Yf6Wky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:52 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)) 03:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Ko1hhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:52 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)) 03:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-SP2lY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:52 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)) 03:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-7AEmeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-jMlhin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-9B36oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-QwrCjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-joAbn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Kmt4ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-InatXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-scxI51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZqL7w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-1Khe0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:53 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-q08wDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:54 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)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:54 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-y3pDqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:54 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)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:54 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Mdy67U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:54 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 03:28:54 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 03:28:54 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 03:28:54 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 03:28:54 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 03:28:54 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 03:28:56 INFO - Downloading blessings-1.6.tar.gz 03:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:56 INFO - Installing collected packages: blessings 03:28:56 INFO - Running setup.py install for blessings 03:28:57 INFO - Successfully installed blessings 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:57 INFO - Reading from file tmpfile_stdout 03:28:57 INFO - Current package versions: 03:28:57 INFO - blessings == 1.6 03:28:57 INFO - blobuploader == 1.2.4 03:28:57 INFO - docopt == 0.6.1 03:28:57 INFO - functools32 == 3.2.3-2 03:28:57 INFO - jsonschema == 2.5.1 03:28:57 INFO - manifestparser == 1.1 03:28:57 INFO - mozInstall == 1.12 03:28:57 INFO - mozcrash == 1.0 03:28:57 INFO - mozdebug == 0.1 03:28:57 INFO - mozdevice == 0.48 03:28:57 INFO - mozfile == 1.2 03:28:57 INFO - mozhttpd == 0.7 03:28:57 INFO - mozinfo == 0.9 03:28:57 INFO - mozleak == 0.1 03:28:57 INFO - mozlog == 3.4 03:28:57 INFO - moznetwork == 0.27 03:28:57 INFO - mozprocess == 0.23 03:28:57 INFO - mozprofile == 0.28 03:28:57 INFO - mozrunner == 6.13 03:28:57 INFO - mozscreenshot == 0.1 03:28:57 INFO - mozsystemmonitor == 0.3 03:28:57 INFO - moztest == 0.7 03:28:57 INFO - mozversion == 1.4 03:28:57 INFO - psutil == 3.1.1 03:28:57 INFO - requests == 1.2.3 03:28:57 INFO - wsgiref == 0.1.2 03:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:57 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')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 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')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:57 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 03:28:57 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 03:28:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:57 INFO - 'HOME': '/Users/cltbld', 03:28:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PAGER': '/bin/cat', 03:28:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:57 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - 'XPC_FLAGS': '0x0', 03:28:57 INFO - 'XPC_SERVICE_NAME': '0', 03:28:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 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)) 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:57 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')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 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')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 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 0x10c769490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6df570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe32c64fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, '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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 03:28:57 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 03:28:57 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 03:28:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:28:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:57 INFO - 'HOME': '/Users/cltbld', 03:28:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PAGER': '/bin/cat', 03:28:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:28:57 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:28:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - 'XPC_FLAGS': '0x0', 03:28:57 INFO - 'XPC_SERVICE_NAME': '0', 03:28:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:58 INFO - Cleaning up... 03:28:58 INFO - Return code: 0 03:28:58 INFO - Running post-action listener: _resource_record_post_action 03:28:58 INFO - Running post-action listener: _start_resource_monitoring 03:28:58 INFO - Starting resource monitoring. 03:28:58 INFO - [mozharness: 2016-11-27 11:28:58.046045Z] Finished create-virtualenv step (success) 03:28:58 INFO - [mozharness: 2016-11-27 11:28:58.047094Z] Running install step. 03:28:58 INFO - Running pre-action listener: _resource_record_pre_action 03:28:58 INFO - Running main action method: install 03:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:58 INFO - Reading from file tmpfile_stdout 03:28:58 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:58 INFO - Reading from file tmpfile_stdout 03:28:58 INFO - Output received: 03:28:58 INFO - Usage: mozinstall [options] installer 03:28:58 INFO - Options: 03:28:58 INFO - -h, --help show this help message and exit 03:28:58 INFO - -d DEST, --destination=DEST 03:28:58 INFO - Directory to install application into. [default: 03:28:58 INFO - "/builds/slave/test"] 03:28:58 INFO - --app=APP Application being installed. [default: firefox] 03:28:58 INFO - mkdir: /builds/slave/test/build/application 03:28:58 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'] 03:28:58 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 03:29:29 INFO - Reading from file tmpfile_stdout 03:29:29 INFO - Output received: 03:29:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:29:29 INFO - Running post-action listener: _resource_record_post_action 03:29:29 INFO - [mozharness: 2016-11-27 11:29:29.176355Z] Finished install step (success) 03:29:29 INFO - [mozharness: 2016-11-27 11:29:29.176506Z] Running run-tests step. 03:29:29 INFO - Running pre-action listener: _resource_record_pre_action 03:29:29 INFO - Running main action method: run_tests 03:29:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:29:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:29:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:29:29 INFO - 2016-11-27 03:29:29.191 screenresolution[2199:39780] starting screenresolution argv=screenresolution get 03:29:29 INFO - 2016-11-27 03:29:29.194 screenresolution[2199:39780] Display 0: 1600x1200x32@60 03:29:29 INFO - 2016-11-27 03:29:29.199 screenresolution[2200:39782] starting screenresolution argv=screenresolution list 03:29:29 INFO - Available Modes on Display 0 03:29:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:29:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:29:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:29:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:29:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:29:29 INFO - Intel Iris: 03:29:29 INFO - Chipset Model: Intel Iris 03:29:29 INFO - Type: GPU 03:29:29 INFO - Bus: Built-In 03:29:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:29:29 INFO - Vendor: Intel (0x8086) 03:29:29 INFO - Device ID: 0x0a2e 03:29:29 INFO - Revision ID: 0x0009 03:29:29 INFO - Displays: 03:29:29 INFO - Display: 03:29:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:29:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:29:29 INFO - Display Serial Number: 1600x1200 60 03:29:29 INFO - Main Display: Yes 03:29:29 INFO - Mirror: Off 03:29:29 INFO - Online: Yes 03:29:29 INFO - Rotation: Supported 03:29:29 INFO - Return code: 0 03:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:29 INFO - Python 2.7.3 03:29:29 INFO - Return code: 0 03:29:29 INFO - grabbing minidump binary from tooltool 03:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:29 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 0x10c57dd30>, '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 0x10c3e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c575b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:29 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 03:29:29 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 03:29:29 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 03:29:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:29 INFO - Return code: 0 03:29:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:29:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:29:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:29 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/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--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 03:29:29 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/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --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 03:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TnIRJBFy0w/Render', 03:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:29:29 INFO - 'HOME': '/Users/cltbld', 03:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:29:29 INFO - 'LOGNAME': 'cltbld', 03:29:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:29 INFO - 'MOZ_NO_REMOTE': '1', 03:29:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:29 INFO - 'NO_EM_RESTART': '1', 03:29:29 INFO - 'PAGER': '/bin/cat', 03:29:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:29 INFO - 'PWD': '/builds/slave/test', 03:29:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:29:29 INFO - 'SHELL': '/bin/bash', 03:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2ORDJrtsnW/Listeners', 03:29:29 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 03:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:29:29 INFO - 'USER': 'cltbld', 03:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:29 INFO - 'XPC_FLAGS': '0x0', 03:29:29 INFO - 'XPC_SERVICE_NAME': '0', 03:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:29:29 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/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--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 03:29:29 INFO - mozversion application_buildid: 20161127004009 03:29:29 INFO - mozversion application_changeset: fe8d7e54713a87a4a356a77ff35b0830a8567e76 03:29:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:29:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:29 INFO - mozversion application_name: Firefox 03:29:29 INFO - mozversion application_remotingname: firefox-dev 03:29:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:29 INFO - mozversion application_vendor: Mozilla 03:29:29 INFO - mozversion application_version: 52.0a2 03:29:29 INFO - mozversion platform_buildid: 20161127004009 03:29:29 INFO - mozversion platform_changeset: fe8d7e54713a87a4a356a77ff35b0830a8567e76 03:29:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:29:29 INFO - mozversion platform_version: 52.0a2 03:29:29 INFO - using testdate: 1480246169 03:29:29 INFO - actual date: 1480246169 03:29:29 INFO - starting webserver on 'localhost:58350' 03:29:29 INFO - SUITE-START | Running 2 tests 03:29:29 INFO - TEST-START | dromaeo_css 03:29:29 INFO - operating with platform_type : mac_ 03:29:29 INFO - Initialising browser for dromaeo_css test... 03:29:29 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpe6CR0D/profile http://localhost:58350/getInfo.html) 03:29:33 INFO - PROCESS | 2210 | __metrics Screen width/height:1600/1200 03:29:33 INFO - PROCESS | 2210 | colorDepth:24 03:29:33 INFO - PROCESS | 2210 | Browser inner width/height: 1024/689 03:29:33 INFO - PROCESS | 2210 | __metrics 03:29:33 ERROR - PROCESS | 2210 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:29:33 INFO - TEST-INFO | 2210: exit 0 03:29:33 INFO - Browser initialized. 03:29:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:33 INFO - TEST-INFO | started process 2214 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpe6CR0D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:46 INFO - PROCESS | 2214 | RSS: Main: 229777408 03:29:46 INFO - PROCESS | 2214 | 03:30:36 INFO - PROCESS | 2214 | 1480246236018 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] 03:32:50 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:58350/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58350/tests/dromaeo/cssquery-ext.html) 03:32:52 INFO - PROCESS | 2214 | RSS: Main: 234258432 03:32:52 INFO - PROCESS | 2214 | 03:35:54 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:58350/tests/dromaeo/cssquery-ext.html (next: http://localhost:58350/tests/dromaeo/cssquery-jquery.html) 03:35:55 INFO - PROCESS | 2214 | RSS: Main: 243486720 03:35:55 INFO - PROCESS | 2214 | 03:38:56 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:58350/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58350/tests/dromaeo/cssquery-mootools.html) 03:38:57 INFO - PROCESS | 2214 | RSS: Main: 246370304 03:38:57 INFO - PROCESS | 2214 | 03:41:59 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:58350/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58350/tests/dromaeo/cssquery-prototype.html) 03:42:00 INFO - PROCESS | 2214 | RSS: Main: 245657600 03:42:00 INFO - PROCESS | 2214 | 03:45:02 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:58350/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58350/tests/dromaeo/cssquery-yui.html) 03:45:03 INFO - PROCESS | 2214 | RSS: Main: 249999360 03:45:03 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:58350/tests/dromaeo/cssquery-yui.html (next: http://localhost:58350/tests/dromaeo/cssquery-dojo.html) 03:48:06 INFO - PROCESS | 2214 | RSS: Main: 251858944 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | __start_tp_report 03:48:06 INFO - PROCESS | 2214 | _x_x_mozilla_page_load 03:48:06 INFO - PROCESS | 2214 | _x_x_mozilla_page_load_details 03:48:06 INFO - PROCESS | 2214 | |i|pagename|runs| 03:48:06 INFO - PROCESS | 2214 | |0;dojo.html;3041.954370684439;3414.7438942079334;3437.9140521486943;3443.5351227584274;3487.180512579544;5843.4156584341545;5853.473187413132;5905.586608937376;5923.407659234074;5936.970315148429;5862.618929769573;5880.353161152269;5909.261342332208;5929.9407005929925;5937;5287.444818294081;5341.492558206984;5353.9196912046355;5390.0836857734275;5391.81128660497;5355.277037599933;5392.649477783951;5394.6493477924005;5408.702521361323;5419.349678038641;5293.57651387888;5343.492368225013;5386.138217885139;5405.405405405402;5432.348118225798;5357.785688572452;5364.927014597096;5405.243265942771;5413.404525502192;5448.83653490396;5241.187615919539;5339.679619222859;5353.304070470853;5396.460353964572;5426.728663566806;6041.969790151065;6044.637321760664;6047.7278522466595;6062.272527296753;6066.8786624267705;6126.019836826086;6169.352218017133;6235.501159907197;6315.147455093549;6323.6521991290465;6255.311915689271;6269.122322874801;6282.87434251317;6364.172657554488;6377.58545694533;6106.877862442726;6114.266288045463;6124.295705993779;6136.570440069241;6138.999999999955;6259.280182778948;6446.967765161145;6462.773802916875;6475.3200913903365;6490.578112422678;5157.484251574812;6087;6188.597741146811;6216.937830621727;6286.18279623646;5347.491988261109;6290.968545157245;6333.651649159248;6337.619742815354;6346.873062538723;6174.598651087755;6238.594491358047;6273.498120150377;6313.084602732578;6318.4313411793155;4581.885452863638;5334;6239.500839932794;6244.906326405107;6262.874742505124;5038.571721403649;5048.596112311006;5070.721110338966;5098.821541246113;5123.129068058439;4521.977390113028;4531.45622525299;4533.478649955231;4550.49944506104;4587.3807036050375;5843.2695913010875;6101.420365065312;6114.296855861544;6131.50947924165;6162.322144564095;6171.228596425447;6264.561480696399;6281.466075383552;6286.088517165077;6366.6180029198395;5997.850053748604;6022.36765139654;6135.07955838608;6153.753849845956;6161.815145545641;5498.725063746797;5502.284702988586;5546.889062218814;5564.4713752193475;5581.246531718166;6545.607263564201;6561.442277406474;6576.276609572943;6583.637899915455;6611.281066922538;6192.938070619236;6307.936920630735;6310.05349197624;6358.523110766619;6381.8085457436355;6411.230652321751;6542.1168142300185;6573.276939536743;6589.80230593083;6601.966990165019;6284.937150628618;6290.905636415366;6293.370662933853;6297.842553936005;6301.590396624205;6108.251008765869;6185.6907154641185;6330.240371155491;6337.4613157882095;6375.553711240169;6132.906245166512;6142.161149281699;6164.198654175108;6197.845053873689;6252.749890004349;6235.220597425322;6239.032949892774;6246.562740608114;6249.656268905072;6251.562390632612;5339.252504649275;5358;6028.4272994065495;6178.505719542516;6233.75064997395;6092.055731361646;6109.847253818512;6112.1387513176505;6173.197484327009;6177.104319873683;5232.895342093061;6140.232470941132;6155.446009859134;6216.160818289473;6225.968870155621 03:48:06 INFO - PROCESS | 2214 | |1;ext.html;487.37372476367864;494.236404754654;521.6974154990106;528.1364968276866;547.29945669543;37843;39468.407973880414;39569.99999999996;39844.80077599608;41133.17733645326;41223;41253;41678.791606042;41708.58291417085;41818.74543763692;9304.906950930506;9473.242140628734;9526.333156679035;9535.80928381432;9535.904640953571;9447.90552094477;9530.618775248982;9536.427814331128;9544.95227523865;9561.521923903812;7839.764807055769;7953;8930.821383572325;9540.80918381632;9582.90417095827;9450.432974021547;9503.192228660571;9515.619375224982;9522.047795220491;9532.046795320482;7524.473286869921;9445.527723613792;9503.382280151836;9508.952455237748;9540.236781057498;38921.61078389208;39536.802315988236;39555.802220989;39648.405273920915;39702.40446393307;2661.2415461593546;2789.9442011159663;3277.901662950115;3278.9671253555052;3298.24140447696;28778.71221287802;29127.271818204503;29811;30311.69688303111;30451;3131.01373067483;3250.5774249347432;3257.5113732940013;3267.313864088544;3375.763696541243;515528;521499;524968;525643;526272;60066.69966650139;60181.69909150426;60554.09168862471;60634.09048864271;60761.392386075575;57686;62550.24698518012;62701.686491568165;62992;63053.36946630567;15707.528774136794;15957.44148954781;16161.515154545383;16192.59518512023;16218.513444596681;12369.752604948031;12404.689882753004;12464.75070498603;12488.687782805502;12521.436535355931;17251.137443127795;18094.5476363092;18193.636127277645;18267.72598411025;18273.543161421072;2880.2367372646268;3258.6415494295607;3298.290867463507;7639.579823109782;7790.182030886788;742.8662840688728;1018.6180182431589;1019.8725159355081;1027.6505987964129;1098.747288123736;28036.71963280382;30036.699633003827;30185.792568297024;30295.545566816516;30645.38709225803;836.7155167243167;951.46242373059;1014.7463134216446;1054.1935419404163;1178.4696886401155;14609.488667896572;14612.707745845024;14653.12081275127;14794.334254958552;15064.171470569225;693191;696589;697786;699052;700860;53093.73453132709;53454.46545534495;53463.732681337126;53700.462995370326;54009.45990540123;1223.443333283354;1330.9600711978655;1367.589723083071;1392.6518370407398;1397.8322601287707;22849.428764281027;27390.726092739616;27762.722372776014;28442;28998;47143.057138857715;47581;47738.76130619325;47789.761051194524;47913.76043119762;619318;619743;620461.8976905086;621463;624174;20800.895995519924;25016.749832501442;25383.36541586475;25409.61885571755;25430;42659.36010959776;43152;43355.78322108369;43738.90652733707;44351;36793.448098278015;36793.448098279085;36853;37058;37154;35472;35584;36423.63576364202;36517.81741091277;36982;35459.82270088633;36085.63914360823;36219.818900905324;36403;36485.45271820978;30786.538201927437;32243.677563224068;32272.515912261806;32696.34607307793;32756;24424.51150976935;24635.63046554339;24673;25113.74886251114;25114.24657260285 03:48:06 INFO - PROCESS | 2214 | |2;jquery.html;336.2297503643318;385.86301862838707;386.73122180084835;388.5201775806878;410.6201763368883;15800.288986995583;16660.416885409013;17044.977301361927;18501.35245266416;19754.01229938501;15980.440684576042;18582.256709731628;18594.53513662159;19053.809461905377;19185.23259069639;5546.77812887484;5831.891940531285;5832.650040997553;5842.970785146068;5853.09277062056;5423.620346575742;5742.6841523716175;5823.563232757539;5824.126381042835;5831.3585505594565;5710.971445142768;5765.048766953448;5773.48038676519;5780.71096445176;5783.479486846183;5481.479259470364;5793.884122317551;5834.329052158992;5880.6765627890445;5899.262592175978;5514.338279406497;5598.216249725042;5686.175504551817;5693.77224911003;5712.514436272922;10563;12597.622071337875;12703.110782245247;12837.935810320982;12936.771006754438;2212.7676593957726;2312.9306120816404;2493.2146373892165;2540.618907163922;2772.1406364027216;9417.62329506819;9493.715188544355;9623;9947.303688741791;10001.849972250422;1709.384621536246;1763.8765286429955;1832.9908350458295;1838.3381982486428;1931.748872646561;113486;119216.40391798073;119349.40325298405;124038.5192296149;124471.9999999991;9248.722538323862;9364.531773411301;9706.514674266258;9861.211103111735;9963.551640176209;12240.959518441032;12308.753824923451;12318.260904345769;12391.62825115248;12416.503339866304;7686.116096648845;7937.880931786028;7950;7970.840583188304;8008.679652813822;8061;8203.466774659628;8257.95871020653;8311.750647480585;8367.121452247547;3607.3687104756564;3807.485989391452;3824.3116239077235;3865.729398942047;3867.41988701697;1846.2522678315036;1932.3719791067679;1936.66108431024;1943.3586916317581;1984.8213660770311;746.9962650186715;802.2619190344897;886.4504007515382;900.6937641202023;920.0293690156815;17458;18087.18607662658;20267.29064482736;20640;21194.576108478053;714.6676795290215;831.4783945379941;861.4228466927174;965.9613615455444;972.863799068131;8160.5103693778565;9116.8632470513;9923.313036783764;10459.320144190604;10503.474826258656;561683;589200;624572;625671;628329;97046;126815;127353.72646273604;129622;130065.0490242647;951.6003278622995;1002.2433063037506;1006.5621454667244;1008.2337423558002;1010.6008126789877;17840.3755868544;17962.281508740027;18421.355252566096;18656.253749850395;18933.242670293035;35560.82219588885;56201.718991404785;57215.9974400894;58139.4186058134;58580;76853.61573192099;78906.6054669723;79931;81738;86808.5659571698;6971.477139214478;7214.376765227782;7277.781666550012;7429.368503677248;7652.693892244471;10652.733681658021;12390.380480975735;12409.503619855466;12436.564720234748;12598.433070512032;10370.585176592851;10549.367037977747;10584;10886.67339979802;11213.60752373663;10308.742281442725;10373.948130259301;10490.947545262225;10591.629292974709;10937.45312734376;9488.430694158373;10863.348199108079;10959.50682219318;11044.171687123659;11097.944510277719;7136;7261.38278246355;7408.555486670817;7408.740694075682;7550.131734850563;9912.801743964936;10445.843312350169;10846.29499082557;10921.017108460277;11078.667639970814 03:48:06 INFO - PROCESS | 2214 | |3;mootools.html;1487.9628009299765;1515.7044376346614;1677.1278934953825;1783.4382169616579;1834.6514162309152;7661.502002369842;7934.047914250284;8272.545010024447;8682.218600325969;8710.651573937042;8137.837243255146;8470.407071504997;8511.74464766058;8596.355273354508;8604.354673399488;2326.1974618756503;2360.268316821791;2364.160722943356;2367.7987371073477;2368.917087901924;2357.5992081346126;2367.2898130560848;2387.057112440585;2402.039184326266;2417.105670901769;2334.2763743239652;2348.9530209395803;2356.4226764442737;2358.1039205102124;2374.3470545599926;2335.4978679583887;2344.4256157241416;2362.3621622162004;2362.385779697274;2366.5266946610573;2363.6572696959015;2366.325597204788;2386.4153282445736;2390.581648211556;2392.377981724747;8545.10276420973;8596.656133754643;8684.392092553524;8715.869261961076;8724.651013959434;5170.870728231786;5315.3090098286975;5322.361316641989;5356.491133342326;5369.952859192459;3520.7887526748223;3615.385384484644;3636.000099972502;3648.835802388899;3694.9838794331504;1052.6157952347414;1062.2776511971856;1093.9671809845718;1095.2114477576133;1096.4024606589428;10818.72953176169;11158.330500169935;11275.436228188557;11280.605178818783;11319.830202546967;4157.542670306264;4524.909501809945;4668.3697700810635;4751;4755.5719985201495;9415.482148481762;9587.520623968774;9651.131398174199;9668.613255469843;9685.612575496902;5276.894462110813;5299.311089558333;5312.415634280226;5315.335583052119;5316.0962636351915;4384.495782984934;4410.647148228134;4852.126617208936;4879.5120487951635;4908;3839.788811615388;3909;3925.9214815703526;3953.6639385651965;3974.8608798691907;1296.1769276509485;1296.7925131978839;1299.7920332746714;1307.2940612069376;1312.875276848698;637.3562701671345;822.6010384963288;908.6092980018524;916.3585490156917;923.0354279777648;5685.914711279334;5737.569682273846;5793.362730099686;5896;5988.341282458926;801.8195905921237;905.4929239625831;932.3753085432776;936.7423958411355;941.3928016429364;3201.855916483764;3939.428782826474;3948.940765888514;3981.1838573092446;4092.6289692953196;9218.985911549724;9864.654737084167;9873.506324683736;10494.055535001886;10514.73713157162;8061.556614386148;9046;10400.739981500523;10486.689163854518;10495.895041049493;7824.921750782533;8158.4289099762445;8174.632141553763;8180.181981801891;8221.876671849926;4407.074514351893;5485.793125512381;5665.235193249024;5750.942490575041;5927.199828023162;9257;9408.717738467856;9641.903580964101;9711.98024207448;9724.562394692115;8174.754757357289;9655.179309758469;9773.364731292444;9933.602655893972;9945.751356216153;6594.472442204708;6821.863562728817;7250.854982900418;7340.889886651597;7499.212582678959;6696;8249.958750206211;8284;8319.792005199919;8321.95975503062;7236.240194779472;7331.8533629328185;7393.223711510214;7485.989391432305;7563.697452101855;7147.928520714726;7242.203357630762;7246.202917679157;7246.782596522113;7258.237885022208;6806.149231346082;6910.965445172742;6913.75801846933;6982.720691172296;6985.860282794417;4791.808327666854;4827.348307978378;4858.319835223142;4946.258061290835;4948.307236986752;4809.543093406261;4950.381202349707;4969.204927211629;5011.523905228997;5063.721495317793 03:48:06 INFO - PROCESS | 2214 | |4;prototype.html;304.24547123134624;305.9128148477684;310.55900621118036;312.5343238574523;320.3576828458941;5103.468959312206;5281.260623512701;5506.834794956148;5656.547476201899;5673.943260567393;4052.298034825373;5280.1551751719735;5489.313835770528;5498.340199176095;5531.321671088721;3435.2957643682985;4212.936805947913;4228.5982831630945;4236.521634843621;4238.936415953764;3905.668018218455;4167.729097608661;4246.2569050416205;4259.190753756776;4270.274053410912;4109.527404348493;4133.098774563689;4142.9378559321485;4156.376543518481;4171.687123465737;3248.4640034394415;3473.947890781628;3625.981870090659;4148.91702165958;4170.562090980434;2782.5687018512162;3214.244652506659;3575.964240357589;3598.604153543108;3731.693907132509;4326.701989403198;5035.974820125876;5413.539849112791;5463.923708990558;5486.725663716838;4028.8589899353674;4818.807247710088;4831.806727730886;4834.903301933977;4853.665242058462;5883.17635531026;5889.617174883619;5913.408659134096;5928.28860536734;5939.644580299082;3489.8080605566684;3503.3343664703625;3636.5636123665063;3799.8790356844797;3972.245273398045;6055.909161362583;6073.817785466443;6086.179259651327;6110.450059494622;6127.6017058891475;3803.3724435468393;3895.8831235062994;4012.578679238638;4019.7588144711412;4038.899772118482;3823.923521529554;4044.8584299549375;4055.8174882130374;4077.918441631151;4096.180763847243;4242.639375653042;4811.735354555533;4815.0146908916695;4824.710517368969;4825.541573550507;5104.923426148611;5286.60350473716;5924.644521328734;5936.821895343147;5938;1232.3160645841645;1248.4007676315418;1310.7875215425693;1323.9404226809816;1326.6815964168723;765.7587859824138;781.7029528779027;883.1698203688512;903.6837107012625;903.814717982812;5201;5275.575594589516;5298.682079075268;5305.445351614428;5308.708021058802;5355.259540649226;5466.863328416742;5562.969516126665;5698.772049118072;5766.116941529235;4933.531314525115;5129.717865517432;5265.341832270966;5272.6836389816735;5282.471752824764;2681.6647919010124;2722.7821774258014;2844.615976843141;2940.6324209473814;3022.871328175328;4850.216830871926;4957.752112394366;5277.736113194325;5566.882545774299;5847.619904706181;4788.760561971888;5137.40919794221;5164.225366195025;5718.79984200551;5882.294124704978;5118.513741194581;5488.890222195534;5555;5780.335261444903;5921.319048309413;5401.519921079058;5722.685252311163;5768;5778.94221057784;5780.68772491007;4953.1579631463455;5136.512031357015;5441.7551210196425;5568.888622227451;5634.4365563443325;5012.824551140692;5612.456574441898;5830.183774271521;5848.970755146197;5914.822555323347;3181.8045548571413;3252.804831710105;3802.821125451119;3834.712396570324;3837.333053527883;5703.857403564944;5839.591228613956;5873.882522349614;6088.056351265561;6107.236595425572;5066.41736200327;5885.705714714161;5956.553258505716;5977.820665379872;5988.341282458839;5978.461938425563;5983.162357270073;6006.549508786771;6008.24896887889;6049.969750151221;4648.372469716545;5381.892362152813;5848.0350742127075;5849.572427442564;5874.618149820248;4798.992211635596;5320.078926992439;5554.167374638882;5939.753076550287;5980.641161530322;4893.877653058702;5372.2747429098135;5815.5929084963645;5852.297724273115;5887.52899768009 03:48:06 INFO - PROCESS | 2214 | |5;yui.html;670.9295523969986;724.3082855872642;725.7568714480649;730.5288089182477;751.1849643137195;11484.540618375255;13058.673533161664;14476.782848257271;14788;14883.851161488381;10594.78810423791;11002.284851484648;13422.66443338917;13467.595972120827;13719.245441500714;711.8647456983157;809.182725447298;827.4993628854546;827.6192951242435;830.3813658824184;649.6913965866199;675.3584095109666;700.8002719225021;807.9151689072651;827.0571548434789;866.7053201911349;877.5656050255101;878.4114643189047;880.0978996528578;881.4358810361374;854.9572521373907;857.6355049104137;876.3996662286354;877.1929824561419;878.6265837019305;625.9499240060784;634.3307810260173;651.501601275025;651.5862427358614;652.4877970792904;14486.058406203563;14487.275636218146;14574.417023319054;14664.193469359181;14714.926425367912;11760.470778814974;13648.317584120754;13872.306384680725;13995.650108747363;14031.298435078204;11136.61021864239;11537.134714896332;11643.01034412076;11651.417429128509;11988.520459181622;3209.646938836726;3656.451532270154;3698.0385099873956;3738.3644780387126;3834.405667121601;96203.51898240464;97143.51428242885;97240;98746;99202;9627.470489123025;9856.655017074512;10462.895371046345;10805.973432524055;10911.618093366853;20962.685559716618;21189.89405052965;21378;21395.786042139378;21712.674309885366;7769.883451748228;7798.415118866108;7799.45403821727;7873.921260787433;7947.682092716226;4124.8143833527565;4164.167166566699;4238.321868501025;4284.378765079046;4350.129974005212;3296.4396052671104;3394.6096198936943;3398.04854640701;3402.778819376782;3404.2340473393288;602.2261394108549;630.908518264849;639.0829160155192;639.9552031357761;647.1134545672459;604.4439116013278;616.8581226317972;618.4990157971968;618.7246675229479;628.833359159823;8246.54643994586;8821.692489869774;8888.60001299943;8985.19133277995;9061.728148155566;591.7189335065896;596.9343372229051;614.5513774944226;617.163743128064;629.858281886581;4091.243120022805;4340.175366680321;4354.804033818486;4357.3899654048455;4454.7549884756;71099;78333.60833195911;100081.4987775184;102886.48556757168;125588.37205814096;95868;98488.50755746175;98694.51958220633;100808;102138.48930755298;88532.11467885367;90852.82770255062;90903.09096909079;93345;93576;9313;9509.429434233969;9873.95063024709;9884.25868059884;9888.060634239735;35925.82037089798;54035.189472157166;55739.72130139486;56120.5969850757;57953;68263.65868170628;68617.65691171512;78239.60880195562;84336;85321;12271.325077120844;12563;12775.041871859834;12814.743705126031;12911;14150.858491415365;14228.217448040457;14378.496752613608;14474.638134046732;14518.346674399889;13034.869651303365;13226.4048117833;13448.596542103753;13497.055206135476;13560.45758169662;12461.93769031149;13039.087263891437;13162.736745265232;13637.522686705917;13676.521321753691;12657.39788695652;13025.218486890439;13204.207747535178;13349.466021359036;13574;10573.418461984666;10885;11230.3261804292;11460.426978651201;11670.70823229426;11416.543338266376;11428.885711142782;11444.542218311175;11491.367974761133;11767.88232117668 03:48:06 INFO - PROCESS | 2214 | __end_tp_report 03:48:06 INFO - PROCESS | 2214 | __start_cc_report 03:48:06 INFO - PROCESS | 2214 | _x_x_mozilla_cycle_collect,365 03:48:06 INFO - PROCESS | 2214 | __end_cc_report 03:48:06 INFO - PROCESS | 2214 | __startTimestamp1480247286505__endTimestamp 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | ------- Summary: start ------- 03:48:06 INFO - PROCESS | 2214 | Number of tests: 6 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | [#0] dojo.html Cycles:165 Average:5856.33 Median:6131.51 stddev:658.97 (10.7%) stddev-sans-first:622.91 03:48:06 INFO - PROCESS | 2214 | Values: 3042.0 3414.7 3437.9 3443.5 3487.2 5843.4 5853.5 5905.6 5923.4 5937.0 5862.6 5880.4 5909.3 5929.9 5937.0 5287.4 5341.5 5353.9 5390.1 5391.8 5355.3 5392.6 5394.6 5408.7 5419.3 5293.6 5343.5 5386.1 5405.4 5432.3 5357.8 5364.9 5405.2 5413.4 5448.8 5241.2 5339.7 5353.3 5396.5 5426.7 6042.0 6044.6 6047.7 6062.3 6066.9 6126.0 6169.4 6235.5 6315.1 6323.7 6255.3 6269.1 6282.9 6364.2 6377.6 6106.9 6114.3 6124.3 6136.6 6139.0 6259.3 6447.0 6462.8 6475.3 6490.6 5157.5 6087.0 6188.6 6216.9 6286.2 5347.5 6291.0 6333.7 6337.6 6346.9 6174.6 6238.6 6273.5 6313.1 6318.4 4581.9 5334.0 6239.5 6244.9 6262.9 5038.6 5048.6 5070.7 5098.8 5123.1 4522.0 4531.5 4533.5 4550.5 4587.4 5843.3 6101.4 6114.3 6131.5 6162.3 6171.2 6264.6 6281.5 6286.1 6366.6 5997.9 6022.4 6135.1 6153.8 6161.8 5498.7 5502.3 5546.9 5564.5 5581.2 6545.6 6561.4 6576.3 6583.6 6611.3 6192.9 6307.9 6310.1 6358.5 6381.8 6411.2 6542.1 6573.3 6589.8 6602.0 6284.9 6290.9 6293.4 6297.8 6301.6 6108.3 6185.7 6330.2 6337.5 6375.6 6132.9 6142.2 6164.2 6197.8 6252.7 6235.2 6239.0 6246.6 6249.7 6251.6 5339.3 5358.0 6028.4 6178.5 6233.8 6092.1 6109.8 6112.1 6173.2 6177.1 5232.9 6140.2 6155.4 6216.2 6226.0 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | [#1] ext.html Cycles:180 Average:73021.27 Median:38382.31 stddev:165711.87 (431.7%) stddev-sans-first:166087.25 03:48:06 INFO - PROCESS | 2214 | Values: 487.4 494.2 521.7 528.1 547.3 37843.0 39468.4 39570.0 39844.8 41133.2 41223.0 41253.0 41678.8 41708.6 41818.7 9304.9 9473.2 9526.3 9535.8 9535.9 9447.9 9530.6 9536.4 9545.0 9561.5 7839.8 7953.0 8930.8 9540.8 9582.9 9450.4 9503.2 9515.6 9522.0 9532.0 7524.5 9445.5 9503.4 9509.0 9540.2 38921.6 39536.8 39555.8 39648.4 39702.4 2661.2 2789.9 3277.9 3279.0 3298.2 28778.7 29127.3 29811.0 30311.7 30451.0 3131.0 3250.6 3257.5 3267.3 3375.8 515528.0 521499.0 524968.0 525643.0 526272.0 60066.7 60181.7 60554.1 60634.1 60761.4 57686.0 62550.2 62701.7 62992.0 63053.4 15707.5 15957.4 16161.5 16192.6 16218.5 12369.8 12404.7 12464.8 12488.7 12521.4 17251.1 18094.5 18193.6 18267.7 18273.5 2880.2 3258.6 3298.3 7639.6 7790.2 742.9 1018.6 1019.9 1027.7 1098.7 28036.7 30036.7 30185.8 30295.5 30645.4 836.7 951.5 1014.7 1054.2 1178.5 14609.5 14612.7 14653.1 14794.3 15064.2 693191.0 696589.0 697786.0 699052.0 700860.0 53093.7 53454.5 53463.7 53700.5 54009.5 1223.4 1331.0 1367.6 1392.7 1397.8 22849.4 27390.7 27762.7 28442.0 28998.0 47143.1 47581.0 47738.8 47789.8 47913.8 619318.0 619743.0 620461.9 621463.0 624174.0 20800.9 25016.7 25383.4 25409.6 25430.0 42659.4 43152.0 43355.8 43738.9 44351.0 36793.4 36793.4 36853.0 37058.0 37154.0 35472.0 35584.0 36423.6 36517.8 36982.0 35459.8 36085.6 36219.8 36403.0 36485.5 30786.5 32243.7 32272.5 32696.3 32756.0 24424.5 24635.6 24673.0 25113.7 25114.2 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | [#2] jquery.html Cycles:180 Average:34355.95 Median:2126.23 stddev:101286.86 (4763.7%) stddev-sans-first:101538.79 03:48:06 INFO - PROCESS | 2214 | Values: 336.2 385.9 386.7 388.5 410.6 15800.3 16660.4 17045.0 18501.4 19754.0 15980.4 18582.3 18594.5 19053.8 19185.2 5546.8 5831.9 5832.7 5843.0 5853.1 5423.6 5742.7 5823.6 5824.1 5831.4 5711.0 5765.0 5773.5 5780.7 5783.5 5481.5 5793.9 5834.3 5880.7 5899.3 5514.3 5598.2 5686.2 5693.8 5712.5 10563.0 12597.6 12703.1 12837.9 12936.8 2212.8 2312.9 2493.2 2540.6 2772.1 9417.6 9493.7 9623.0 9947.3 10001.8 1709.4 1763.9 1833.0 1838.3 1931.7 113486.0 119216.4 119349.4 124038.5 124472.0 9248.7 9364.5 9706.5 9861.2 9963.6 12241.0 12308.8 12318.3 12391.6 12416.5 7686.1 7937.9 7950.0 7970.8 8008.7 8061.0 8203.5 8258.0 8311.8 8367.1 3607.4 3807.5 3824.3 3865.7 3867.4 1846.3 1932.4 1936.7 1943.4 1984.8 747.0 802.3 886.5 900.7 920.0 17458.0 18087.2 20267.3 20640.0 21194.6 714.7 831.5 861.4 966.0 972.9 8160.5 9116.9 9923.3 10459.3 10503.5 561683.0 589200.0 624572.0 625671.0 628329.0 97046.0 126815.0 127353.7 129622.0 130065.0 951.6 1002.2 1006.6 1008.2 1010.6 17840.4 17962.3 18421.4 18656.3 18933.2 35560.8 56201.7 57216.0 58139.4 58580.0 76853.6 78906.6 79931.0 81738.0 86808.6 6971.5 7214.4 7277.8 7429.4 7652.7 10652.7 12390.4 12409.5 12436.6 12598.4 10370.6 10549.4 10584.0 10886.7 11213.6 10308.7 10373.9 10490.9 10591.6 10937.5 9488.4 10863.3 10959.5 11044.2 11097.9 7136.0 7261.4 7408.6 7408.7 7550.1 9912.8 10445.8 10846.3 10921.0 11078.7 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | [#3] mootools.html Cycles:180 Average:5544.04 Median:5315.32 stddev:3025.01 (56.9%) stddev-sans-first:3018.14 03:48:06 INFO - PROCESS | 2214 | Values: 1488.0 1515.7 1677.1 1783.4 1834.7 7661.5 7934.0 8272.5 8682.2 8710.7 8137.8 8470.4 8511.7 8596.4 8604.4 2326.2 2360.3 2364.2 2367.8 2368.9 2357.6 2367.3 2387.1 2402.0 2417.1 2334.3 2349.0 2356.4 2358.1 2374.3 2335.5 2344.4 2362.4 2362.4 2366.5 2363.7 2366.3 2386.4 2390.6 2392.4 8545.1 8596.7 8684.4 8715.9 8724.7 5170.9 5315.3 5322.4 5356.5 5370.0 3520.8 3615.4 3636.0 3648.8 3695.0 1052.6 1062.3 1094.0 1095.2 1096.4 10818.7 11158.3 11275.4 11280.6 11319.8 4157.5 4524.9 4668.4 4751.0 4755.6 9415.5 9587.5 9651.1 9668.6 9685.6 5276.9 5299.3 5312.4 5315.3 5316.1 4384.5 4410.6 4852.1 4879.5 4908.0 3839.8 3909.0 3925.9 3953.7 3974.9 1296.2 1296.8 1299.8 1307.3 1312.9 637.4 822.6 908.6 916.4 923.0 5685.9 5737.6 5793.4 5896.0 5988.3 801.8 905.5 932.4 936.7 941.4 3201.9 3939.4 3948.9 3981.2 4092.6 9219.0 9864.7 9873.5 10494.1 10514.7 8061.6 9046.0 10400.7 10486.7 10495.9 7824.9 8158.4 8174.6 8180.2 8221.9 4407.1 5485.8 5665.2 5750.9 5927.2 9257.0 9408.7 9641.9 9712.0 9724.6 8174.8 9655.2 9773.4 9933.6 9945.8 6594.5 6821.9 7250.9 7340.9 7499.2 6696.0 8250.0 8284.0 8319.8 8322.0 7236.2 7331.9 7393.2 7486.0 7563.7 7147.9 7242.2 7246.2 7246.8 7258.2 6806.1 6911.0 6913.8 6982.7 6985.9 4791.8 4827.3 4858.3 4946.3 4948.3 4809.5 4950.4 4969.2 5011.5 5063.7 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | [#4] prototype.html Cycles:180 Average:4611.76 Median:5233.17 stddev:1451.72 (27.7%) stddev-sans-first:1419.33 03:48:06 INFO - PROCESS | 2214 | Values: 304.2 305.9 310.6 312.5 320.4 5103.5 5281.3 5506.8 5656.5 5673.9 4052.3 5280.2 5489.3 5498.3 5531.3 3435.3 4212.9 4228.6 4236.5 4238.9 3905.7 4167.7 4246.3 4259.2 4270.3 4109.5 4133.1 4142.9 4156.4 4171.7 3248.5 3473.9 3626.0 4148.9 4170.6 2782.6 3214.2 3576.0 3598.6 3731.7 4326.7 5036.0 5413.5 5463.9 5486.7 4028.9 4818.8 4831.8 4834.9 4853.7 5883.2 5889.6 5913.4 5928.3 5939.6 3489.8 3503.3 3636.6 3799.9 3972.2 6055.9 6073.8 6086.2 6110.5 6127.6 3803.4 3895.9 4012.6 4019.8 4038.9 3823.9 4044.9 4055.8 4077.9 4096.2 4242.6 4811.7 4815.0 4824.7 4825.5 5104.9 5286.6 5924.6 5936.8 5938.0 1232.3 1248.4 1310.8 1323.9 1326.7 765.8 781.7 883.2 903.7 903.8 5201.0 5275.6 5298.7 5305.4 5308.7 5355.3 5466.9 5563.0 5698.8 5766.1 4933.5 5129.7 5265.3 5272.7 5282.5 2681.7 2722.8 2844.6 2940.6 3022.9 4850.2 4957.8 5277.7 5566.9 5847.6 4788.8 5137.4 5164.2 5718.8 5882.3 5118.5 5488.9 5555.0 5780.3 5921.3 5401.5 5722.7 5768.0 5778.9 5780.7 4953.2 5136.5 5441.8 5568.9 5634.4 5012.8 5612.5 5830.2 5849.0 5914.8 3181.8 3252.8 3802.8 3834.7 3837.3 5703.9 5839.6 5873.9 6088.1 6107.2 5066.4 5885.7 5956.6 5977.8 5988.3 5978.5 5983.2 6006.5 6008.2 6050.0 4648.4 5381.9 5848.0 5849.6 5874.6 4799.0 5320.1 5554.2 5939.8 5980.6 4893.9 5372.3 5815.6 5852.3 5887.5 03:48:06 INFO - PROCESS | 2214 | 03:48:06 INFO - PROCESS | 2214 | [#5] yui.html Cycles:180 Average:20781.41 Median:4352.47 stddev:30522.64 (701.3%) stddev-sans-first:30570.91 03:48:06 INFO - PROCESS | 2214 | Values: 670.9 724.3 725.8 730.5 751.2 11484.5 13058.7 14476.8 14788.0 14883.9 10594.8 11002.3 13422.7 13467.6 13719.2 711.9 809.2 827.5 827.6 830.4 649.7 675.4 700.8 807.9 827.1 866.7 877.6 878.4 880.1 881.4 855.0 857.6 876.4 877.2 878.6 625.9 634.3 651.5 651.6 652.5 14486.1 14487.3 14574.4 14664.2 14714.9 11760.5 13648.3 13872.3 13995.7 14031.3 11136.6 11537.1 11643.0 11651.4 11988.5 3209.6 3656.5 3698.0 3738.4 3834.4 96203.5 97143.5 97240.0 98746.0 99202.0 9627.5 9856.7 10462.9 10806.0 10911.6 20962.7 21189.9 21378.0 21395.8 21712.7 7769.9 7798.4 7799.5 7873.9 7947.7 4124.8 4164.2 4238.3 4284.4 4350.1 3296.4 3394.6 3398.0 3402.8 3404.2 602.2 630.9 639.1 640.0 647.1 604.4 616.9 618.5 618.7 628.8 8246.5 8821.7 8888.6 8985.2 9061.7 591.7 596.9 614.6 617.2 629.9 4091.2 4340.2 4354.8 4357.4 4454.8 71099.0 78333.6 100081.5 102886.5 125588.4 95868.0 98488.5 98694.5 100808.0 102138.5 88532.1 90852.8 90903.1 93345.0 93576.0 9313.0 9509.4 9874.0 9884.3 9888.1 35925.8 54035.2 55739.7 56120.6 57953.0 68263.7 68617.7 78239.6 84336.0 85321.0 12271.3 12563.0 12775.0 12814.7 12911.0 14150.9 14228.2 14378.5 14474.6 14518.3 13034.9 13226.4 13448.6 13497.1 13560.5 12461.9 13039.1 13162.7 13637.5 13676.5 12657.4 13025.2 13204.2 13349.5 13574.0 10573.4 10885.0 11230.3 11460.4 11670.7 11416.5 11428.9 11444.5 11491.4 11767.9 03:48:06 INFO - PROCESS | 2214 | -------- Summary: end -------- 03:48:06 INFO - PROCESS | 2214 | 03:48:07 INFO - TEST-INFO | 2214: exit 0 03:48:07 INFO - TEST-OK | dromaeo_css | took 1117382ms 03:48:07 INFO - TEST-START | kraken 03:48:07 INFO - operating with platform_type : mac_ 03:48:07 INFO - Initialising browser for kraken test... 03:48:07 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmp3RDhin/profile http://localhost:58350/getInfo.html) 03:48:09 INFO - PROCESS | 2241 | __metrics Screen width/height:1600/1200 03:48:09 INFO - PROCESS | 2241 | colorDepth:24 03:48:09 INFO - PROCESS | 2241 | Browser inner width/height: 1024/689 03:48:09 INFO - PROCESS | 2241 | __metrics 03:48:10 ERROR - PROCESS | 2241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:48:10 INFO - TEST-INFO | 2241: exit 0 03:48:10 INFO - Browser initialized. 03:48:10 INFO - Running cycle 1/1 for kraken test... 03:48:10 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmp3RDhin/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:23 INFO - PROCESS | 2244 | RSS: Main: 229974016 03:48:23 INFO - PROCESS | 2244 | 03:48:26 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58350/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:27 INFO - PROCESS | 2244 | RSS: Main: 241922048 03:48:27 INFO - PROCESS | 2244 | 03:48:29 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58350/tests/kraken/driver.html?testName=audio-dft) 03:48:30 INFO - PROCESS | 2244 | RSS: Main: 249442304 03:48:30 INFO - PROCESS | 2244 | 03:48:33 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58350/tests/kraken/driver.html?testName=audio-fft) 03:48:34 INFO - PROCESS | 2244 | RSS: Main: 253116416 03:48:34 INFO - PROCESS | 2244 | 03:48:36 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58350/tests/kraken/driver.html?testName=audio-oscillator) 03:48:36 INFO - PROCESS | 2244 | RSS: Main: 254480384 03:48:36 INFO - PROCESS | 2244 | 03:48:38 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58350/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:39 INFO - PROCESS | 2244 | RSS: Main: 254750720 03:48:39 INFO - PROCESS | 2244 | 03:48:42 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58350/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:43 INFO - PROCESS | 2244 | RSS: Main: 258658304 03:48:43 INFO - PROCESS | 2244 | 03:48:46 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58350/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:47 INFO - PROCESS | 2244 | RSS: Main: 257814528 03:48:47 INFO - PROCESS | 2244 | 03:48:49 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58350/tests/kraken/driver.html?testName=json-parse-financial) 03:48:50 INFO - PROCESS | 2244 | RSS: Main: 258072576 03:48:50 INFO - PROCESS | 2244 | 03:48:52 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58350/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:52 INFO - PROCESS | 2244 | RSS: Main: 257273856 03:48:52 INFO - PROCESS | 2244 | 03:48:54 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:55 INFO - PROCESS | 2244 | RSS: Main: 257212416 03:48:55 INFO - PROCESS | 2244 | 03:48:57 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:58 INFO - PROCESS | 2244 | RSS: Main: 257232896 03:48:58 INFO - PROCESS | 2244 | 03:49:01 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:02 INFO - PROCESS | 2244 | RSS: Main: 257626112 03:49:02 INFO - PROCESS | 2244 | 03:49:04 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:05 INFO - PROCESS | 2244 | RSS: Main: 257712128 03:49:05 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | Cycle 1(1): loaded http://localhost:58350/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58350/tests/kraken/driver.html?testName=ai-astar) 03:49:07 INFO - PROCESS | 2244 | RSS: Main: 258973696 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | __start_tp_report 03:49:07 INFO - PROCESS | 2244 | _x_x_mozilla_page_load 03:49:07 INFO - PROCESS | 2244 | _x_x_mozilla_page_load_details 03:49:07 INFO - PROCESS | 2244 | |i|pagename|runs| 03:49:07 INFO - PROCESS | 2244 | |0;ai-astar;107;119;119;121;173;171;167;101;173;176 03:49:07 INFO - PROCESS | 2244 | |1;audio-beat-detection;146;116;128;180;112;115;118;118;152;142 03:49:07 INFO - PROCESS | 2244 | |2;audio-dft;196;196;195;202;198;195;196;198;196;196 03:49:07 INFO - PROCESS | 2244 | |3;audio-fft;84;57;61;88;62;59;60;60;69;60 03:49:07 INFO - PROCESS | 2244 | |4;audio-oscillator;123;71;91;72;69;70;86;68;72;88 03:49:07 INFO - PROCESS | 2244 | |5;imaging-gaussian-blur;96;76;133;128;136;132;137;85;102;131 03:49:07 INFO - PROCESS | 2244 | |6;imaging-darkroom;99;100;99;98;115;148;170;100;99;102 03:49:07 INFO - PROCESS | 2244 | |7;imaging-desaturate;94;93;86;87;91;94;90;97;89;91 03:49:07 INFO - PROCESS | 2244 | |8;json-parse-financial;56;57;57;67;92;93;92;93;87;61 03:49:07 INFO - PROCESS | 2244 | |9;json-stringify-tinderbox;70;76;78;98;92;101;104;80;75;73 03:49:07 INFO - PROCESS | 2244 | |10;stanford-crypto-aes;89;89;89;85;84;87;85;87;97;107 03:49:07 INFO - PROCESS | 2244 | |11;stanford-crypto-ccm;147;140;151;163;166;153;153;154;199;167 03:49:07 INFO - PROCESS | 2244 | |12;stanford-crypto-pbkdf2;167;171;170;170;168;171;172;170;170;168 03:49:07 INFO - PROCESS | 2244 | |13;stanford-crypto-sha256-iterative;70;68;68;67;70;67;67;70;67;69 03:49:07 INFO - PROCESS | 2244 | __end_tp_report 03:49:07 INFO - PROCESS | 2244 | __start_cc_report 03:49:07 INFO - PROCESS | 2244 | _x_x_mozilla_cycle_collect,972 03:49:07 INFO - PROCESS | 2244 | __end_cc_report 03:49:07 INFO - PROCESS | 2244 | __startTimestamp1480247347559__endTimestamp 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | ------- Summary: start ------- 03:49:07 INFO - PROCESS | 2244 | Number of tests: 14 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#0] ai-astar Cycles:10 Average:142.70 Median:169.00 stddev:31.52 (18.7%) stddev-sans-first:30.68 03:49:07 INFO - PROCESS | 2244 | Values: 107.0 119.0 119.0 121.0 173.0 171.0 167.0 101.0 173.0 176.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:135.00 stddev:21.98 (16.3%) stddev-sans-first:22.78 03:49:07 INFO - PROCESS | 2244 | Values: 146.0 116.0 128.0 180.0 112.0 115.0 118.0 118.0 152.0 142.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#2] audio-dft Cycles:10 Average:196.80 Median:196.00 stddev:2.10 (1.1%) stddev-sans-first:2.20 03:49:07 INFO - PROCESS | 2244 | Values: 196.0 196.0 195.0 202.0 198.0 195.0 196.0 198.0 196.0 196.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#3] audio-fft Cycles:10 Average:66.00 Median:61.50 stddev:11.04 (17.9%) stddev-sans-first:9.59 03:49:07 INFO - PROCESS | 2244 | Values: 84.0 57.0 61.0 88.0 62.0 59.0 60.0 60.0 69.0 60.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#4] audio-oscillator Cycles:10 Average:81.00 Median:72.00 stddev:17.11 (23.8%) stddev-sans-first:9.18 03:49:07 INFO - PROCESS | 2244 | Values: 123.0 71.0 91.0 72.0 69.0 70.0 86.0 68.0 72.0 88.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:136.50 stddev:23.36 (17.1%) stddev-sans-first:23.67 03:49:07 INFO - PROCESS | 2244 | Values: 96.0 76.0 133.0 128.0 136.0 132.0 137.0 85.0 102.0 131.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#6] imaging-darkroom Cycles:10 Average:113.00 Median:134.00 stddev:25.28 (18.9%) stddev-sans-first:26.30 03:49:07 INFO - PROCESS | 2244 | Values: 99.0 100.0 99.0 98.0 115.0 148.0 170.0 100.0 99.0 102.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:92.00 stddev:3.39 (3.7%) stddev-sans-first:3.44 03:49:07 INFO - PROCESS | 2244 | Values: 94.0 93.0 86.0 87.0 91.0 94.0 90.0 97.0 89.0 91.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#8] json-parse-financial Cycles:10 Average:75.50 Median:89.50 stddev:17.12 (19.1%) stddev-sans-first:16.64 03:49:07 INFO - PROCESS | 2244 | Values: 56.0 57.0 57.0 67.0 92.0 93.0 92.0 93.0 87.0 61.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#9] json-stringify-tinderbox Cycles:10 Average:84.70 Median:77.00 stddev:12.73 (16.5%) stddev-sans-first:12.34 03:49:07 INFO - PROCESS | 2244 | Values: 70.0 76.0 78.0 98.0 92.0 101.0 104.0 80.0 75.0 73.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:7.03 (8.0%) stddev-sans-first:7.45 03:49:07 INFO - PROCESS | 2244 | Values: 89.0 89.0 89.0 85.0 84.0 87.0 85.0 87.0 97.0 107.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#11] stanford-crypto-ccm Cycles:10 Average:159.30 Median:158.50 stddev:16.31 (10.3%) stddev-sans-first:16.68 03:49:07 INFO - PROCESS | 2244 | Values: 147.0 140.0 151.0 163.0 166.0 153.0 153.0 154.0 199.0 167.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.00 stddev:1.57 (0.9%) stddev-sans-first:1.32 03:49:07 INFO - PROCESS | 2244 | Values: 167.0 171.0 170.0 170.0 168.0 171.0 172.0 170.0 170.0 168.0 03:49:07 INFO - PROCESS | 2244 | 03:49:07 INFO - PROCESS | 2244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.34 (2.0%) stddev-sans-first:1.27 03:49:07 INFO - PROCESS | 2244 | Values: 70.0 68.0 68.0 67.0 70.0 67.0 67.0 70.0 67.0 69.0 03:49:07 INFO - PROCESS | 2244 | -------- Summary: end -------- 03:49:07 INFO - PROCESS | 2244 | 03:49:08 INFO - TEST-INFO | 2244: exit 0 03:49:08 INFO - TEST-OK | kraken | took 61391ms 03:49:08 INFO - SUITE-END | took 1178s 03:49:08 INFO - Completed test suite (00:19:38) 03:49:08 INFO - javascript benchmark 03:49:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7173.1569556040995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3041.954370684439, 3414.7438942079334, 3437.9140521486943, 3443.5351227584274, 3487.180512579544, 5843.4156584341545, 5853.473187413132, 5905.586608937376, 5923.407659234074, 5936.970315148429, 5862.618929769573, 5880.353161152269, 5909.261342332208, 5929.9407005929925, 5937.0, 5287.444818294081, 5341.492558206984, 5353.9196912046355, 5390.0836857734275, 5391.81128660497, 5355.277037599933, 5392.649477783951, 5394.6493477924005, 5408.702521361323, 5419.349678038641, 5293.57651387888, 5343.492368225013, 5386.138217885139, 5405.405405405402, 5432.348118225798, 5357.785688572452, 5364.927014597096, 5405.243265942771, 5413.404525502192, 5448.83653490396, 5241.187615919539, 5339.679619222859, 5353.304070470853, 5396.460353964572, 5426.728663566806, 6041.969790151065, 6044.637321760664, 6047.7278522466595, 6062.272527296753, 6066.8786624267705, 6126.019836826086, 6169.352218017133, 6235.501159907197, 6315.147455093549, 6323.6521991290465, 6255.311915689271, 6269.122322874801, 6282.87434251317, 6364.172657554488, 6377.58545694533, 6106.877862442726, 6114.266288045463, 6124.295705993779, 6136.570440069241, 6138.999999999955, 6259.280182778948, 6446.967765161145, 6462.773802916875, 6475.3200913903365, 6490.578112422678, 5157.484251574812, 6087.0, 6188.597741146811, 6216.937830621727, 6286.18279623646, 5347.491988261109, 6290.968545157245, 6333.651649159248, 6337.619742815354, 6346.873062538723, 6174.598651087755, 6238.594491358047, 6273.498120150377, 6313.084602732578, 6318.4313411793155, 4581.885452863638, 5334.0, 6239.500839932794, 6244.906326405107, 6262.874742505124, 5038.571721403649, 5048.596112311006, 5070.721110338966, 5098.821541246113, 5123.129068058439, 4521.977390113028, 4531.45622525299, 4533.478649955231, 4550.49944506104, 4587.3807036050375, 5843.2695913010875, 6101.420365065312, 6114.296855861544, 6131.50947924165, 6162.322144564095, 6171.228596425447, 6264.561480696399, 6281.466075383552, 6286.088517165077, 6366.6180029198395, 5997.850053748604, 6022.36765139654, 6135.07955838608, 6153.753849845956, 6161.815145545641, 5498.725063746797, 5502.284702988586, 5546.889062218814, 5564.4713752193475, 5581.246531718166, 6545.607263564201, 6561.442277406474, 6576.276609572943, 6583.637899915455, 6611.281066922538, 6192.938070619236, 6307.936920630735, 6310.05349197624, 6358.523110766619, 6381.8085457436355, 6411.230652321751, 6542.1168142300185, 6573.276939536743, 6589.80230593083, 6601.966990165019, 6284.937150628618, 6290.905636415366, 6293.370662933853, 6297.842553936005, 6301.590396624205, 6108.251008765869, 6185.6907154641185, 6330.240371155491, 6337.4613157882095, 6375.553711240169, 6132.906245166512, 6142.161149281699, 6164.198654175108, 6197.845053873689, 6252.749890004349, 6235.220597425322, 6239.032949892774, 6246.562740608114, 6249.656268905072, 6251.562390632612, 5339.252504649275, 5358.0, 6028.4272994065495, 6178.505719542516, 6233.75064997395, 6092.055731361646, 6109.847253818512, 6112.1387513176505, 6173.197484327009, 6177.104319873683, 5232.895342093061, 6140.232470941132, 6155.446009859134, 6216.160818289473, 6225.968870155621], "value": 5815.24479776415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.37372476367864, 494.236404754654, 521.6974154990106, 528.1364968276866, 547.29945669543, 37843.0, 39468.407973880414, 39569.99999999996, 39844.80077599608, 41133.17733645326, 41223.0, 41253.0, 41678.791606042, 41708.58291417085, 41818.74543763692, 9304.906950930506, 9473.242140628734, 9526.333156679035, 9535.80928381432, 9535.904640953571, 9447.90552094477, 9530.618775248982, 9536.427814331128, 9544.95227523865, 9561.521923903812, 7839.764807055769, 7953.0, 8930.821383572325, 9540.80918381632, 9582.90417095827, 9450.432974021547, 9503.192228660571, 9515.619375224982, 9522.047795220491, 9532.046795320482, 7524.473286869921, 9445.527723613792, 9503.382280151836, 9508.952455237748, 9540.236781057498, 38921.61078389208, 39536.802315988236, 39555.802220989, 39648.405273920915, 39702.40446393307, 2661.2415461593546, 2789.9442011159663, 3277.901662950115, 3278.9671253555052, 3298.24140447696, 28778.71221287802, 29127.271818204503, 29811.0, 30311.69688303111, 30451.0, 3131.01373067483, 3250.5774249347432, 3257.5113732940013, 3267.313864088544, 3375.763696541243, 515528.0, 521499.0, 524968.0, 525643.0, 526272.0, 60066.69966650139, 60181.69909150426, 60554.09168862471, 60634.09048864271, 60761.392386075575, 57686.0, 62550.24698518012, 62701.686491568165, 62992.0, 63053.36946630567, 15707.528774136794, 15957.44148954781, 16161.515154545383, 16192.59518512023, 16218.513444596681, 12369.752604948031, 12404.689882753004, 12464.75070498603, 12488.687782805502, 12521.436535355931, 17251.137443127795, 18094.5476363092, 18193.636127277645, 18267.72598411025, 18273.543161421072, 2880.2367372646268, 3258.6415494295607, 3298.290867463507, 7639.579823109782, 7790.182030886788, 742.8662840688728, 1018.6180182431589, 1019.8725159355081, 1027.6505987964129, 1098.747288123736, 28036.71963280382, 30036.699633003827, 30185.792568297024, 30295.545566816516, 30645.38709225803, 836.7155167243167, 951.46242373059, 1014.7463134216446, 1054.1935419404163, 1178.4696886401155, 14609.488667896572, 14612.707745845024, 14653.12081275127, 14794.334254958552, 15064.171470569225, 693191.0, 696589.0, 697786.0, 699052.0, 700860.0, 53093.73453132709, 53454.46545534495, 53463.732681337126, 53700.462995370326, 54009.45990540123, 1223.443333283354, 1330.9600711978655, 1367.589723083071, 1392.6518370407398, 1397.8322601287707, 22849.428764281027, 27390.726092739616, 27762.722372776014, 28442.0, 28998.0, 47143.057138857715, 47581.0, 47738.76130619325, 47789.761051194524, 47913.76043119762, 619318.0, 619743.0, 620461.8976905086, 621463.0, 624174.0, 20800.895995519924, 25016.749832501442, 25383.36541586475, 25409.61885571755, 25430.0, 42659.36010959776, 43152.0, 43355.78322108369, 43738.90652733707, 44351.0, 36793.448098278015, 36793.448098279085, 36853.0, 37058.0, 37154.0, 35472.0, 35584.0, 36423.63576364202, 36517.81741091277, 36982.0, 35459.82270088633, 36085.63914360823, 36219.818900905324, 36403.0, 36485.45271820978, 30786.538201927437, 32243.677563224068, 32272.515912261806, 32696.34607307793, 32756.0, 24424.51150976935, 24635.63046554339, 24673.0, 25113.74886251114, 25114.24657260285], "value": 19238.982415478218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.2297503643318, 385.86301862838707, 386.73122180084835, 388.5201775806878, 410.6201763368883, 15800.288986995583, 16660.416885409013, 17044.977301361927, 18501.35245266416, 19754.01229938501, 15980.440684576042, 18582.256709731628, 18594.53513662159, 19053.809461905377, 19185.23259069639, 5546.77812887484, 5831.891940531285, 5832.650040997553, 5842.970785146068, 5853.09277062056, 5423.620346575742, 5742.6841523716175, 5823.563232757539, 5824.126381042835, 5831.3585505594565, 5710.971445142768, 5765.048766953448, 5773.48038676519, 5780.71096445176, 5783.479486846183, 5481.479259470364, 5793.884122317551, 5834.329052158992, 5880.6765627890445, 5899.262592175978, 5514.338279406497, 5598.216249725042, 5686.175504551817, 5693.77224911003, 5712.514436272922, 10563.0, 12597.622071337875, 12703.110782245247, 12837.935810320982, 12936.771006754438, 2212.7676593957726, 2312.9306120816404, 2493.2146373892165, 2540.618907163922, 2772.1406364027216, 9417.62329506819, 9493.715188544355, 9623.0, 9947.303688741791, 10001.849972250422, 1709.384621536246, 1763.8765286429955, 1832.9908350458295, 1838.3381982486428, 1931.748872646561, 113486.0, 119216.40391798073, 119349.40325298405, 124038.5192296149, 124471.9999999991, 9248.722538323862, 9364.531773411301, 9706.514674266258, 9861.211103111735, 9963.551640176209, 12240.959518441032, 12308.753824923451, 12318.260904345769, 12391.62825115248, 12416.503339866304, 7686.116096648845, 7937.880931786028, 7950.0, 7970.840583188304, 8008.679652813822, 8061.0, 8203.466774659628, 8257.95871020653, 8311.750647480585, 8367.121452247547, 3607.3687104756564, 3807.485989391452, 3824.3116239077235, 3865.729398942047, 3867.41988701697, 1846.2522678315036, 1932.3719791067679, 1936.66108431024, 1943.3586916317581, 1984.8213660770311, 746.9962650186715, 802.2619190344897, 886.4504007515382, 900.6937641202023, 920.0293690156815, 17458.0, 18087.18607662658, 20267.29064482736, 20640.0, 21194.576108478053, 714.6676795290215, 831.4783945379941, 861.4228466927174, 965.9613615455444, 972.863799068131, 8160.5103693778565, 9116.8632470513, 9923.313036783764, 10459.320144190604, 10503.474826258656, 561683.0, 589200.0, 624572.0, 625671.0, 628329.0, 97046.0, 126815.0, 127353.72646273604, 129622.0, 130065.0490242647, 951.6003278622995, 1002.2433063037506, 1006.5621454667244, 1008.2337423558002, 1010.6008126789877, 17840.3755868544, 17962.281508740027, 18421.355252566096, 18656.253749850395, 18933.242670293035, 35560.82219588885, 56201.718991404785, 57215.9974400894, 58139.4186058134, 58580.0, 76853.61573192099, 78906.6054669723, 79931.0, 81738.0, 86808.5659571698, 6971.477139214478, 7214.376765227782, 7277.781666550012, 7429.368503677248, 7652.693892244471, 10652.733681658021, 12390.380480975735, 12409.503619855466, 12436.564720234748, 12598.433070512032, 10370.585176592851, 10549.367037977747, 10584.0, 10886.67339979802, 11213.60752373663, 10308.742281442725, 10373.948130259301, 10490.947545262225, 10591.629292974709, 10937.45312734376, 9488.430694158373, 10863.348199108079, 10959.50682219318, 11044.171687123659, 11097.944510277719, 7136.0, 7261.38278246355, 7408.555486670817, 7408.740694075682, 7550.131734850563, 9912.801743964936, 10445.843312350169, 10846.29499082557, 10921.017108460277, 11078.667639970814], "value": 8956.082059210621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.9628009299765, 1515.7044376346614, 1677.1278934953825, 1783.4382169616579, 1834.6514162309152, 7661.502002369842, 7934.047914250284, 8272.545010024447, 8682.218600325969, 8710.651573937042, 8137.837243255146, 8470.407071504997, 8511.74464766058, 8596.355273354508, 8604.354673399488, 2326.1974618756503, 2360.268316821791, 2364.160722943356, 2367.7987371073477, 2368.917087901924, 2357.5992081346126, 2367.2898130560848, 2387.057112440585, 2402.039184326266, 2417.105670901769, 2334.2763743239652, 2348.9530209395803, 2356.4226764442737, 2358.1039205102124, 2374.3470545599926, 2335.4978679583887, 2344.4256157241416, 2362.3621622162004, 2362.385779697274, 2366.5266946610573, 2363.6572696959015, 2366.325597204788, 2386.4153282445736, 2390.581648211556, 2392.377981724747, 8545.10276420973, 8596.656133754643, 8684.392092553524, 8715.869261961076, 8724.651013959434, 5170.870728231786, 5315.3090098286975, 5322.361316641989, 5356.491133342326, 5369.952859192459, 3520.7887526748223, 3615.385384484644, 3636.000099972502, 3648.835802388899, 3694.9838794331504, 1052.6157952347414, 1062.2776511971856, 1093.9671809845718, 1095.2114477576133, 1096.4024606589428, 10818.72953176169, 11158.330500169935, 11275.436228188557, 11280.605178818783, 11319.830202546967, 4157.542670306264, 4524.909501809945, 4668.3697700810635, 4751.0, 4755.5719985201495, 9415.482148481762, 9587.520623968774, 9651.131398174199, 9668.613255469843, 9685.612575496902, 5276.894462110813, 5299.311089558333, 5312.415634280226, 5315.335583052119, 5316.0962636351915, 4384.495782984934, 4410.647148228134, 4852.126617208936, 4879.5120487951635, 4908.0, 3839.788811615388, 3909.0, 3925.9214815703526, 3953.6639385651965, 3974.8608798691907, 1296.1769276509485, 1296.7925131978839, 1299.7920332746714, 1307.2940612069376, 1312.875276848698, 637.3562701671345, 822.6010384963288, 908.6092980018524, 916.3585490156917, 923.0354279777648, 5685.914711279334, 5737.569682273846, 5793.362730099686, 5896.0, 5988.341282458926, 801.8195905921237, 905.4929239625831, 932.3753085432776, 936.7423958411355, 941.3928016429364, 3201.855916483764, 3939.428782826474, 3948.940765888514, 3981.1838573092446, 4092.6289692953196, 9218.985911549724, 9864.654737084167, 9873.506324683736, 10494.055535001886, 10514.73713157162, 8061.556614386148, 9046.0, 10400.739981500523, 10486.689163854518, 10495.895041049493, 7824.921750782533, 8158.4289099762445, 8174.632141553763, 8180.181981801891, 8221.876671849926, 4407.074514351893, 5485.793125512381, 5665.235193249024, 5750.942490575041, 5927.199828023162, 9257.0, 9408.717738467856, 9641.903580964101, 9711.98024207448, 9724.562394692115, 8174.754757357289, 9655.179309758469, 9773.364731292444, 9933.602655893972, 9945.751356216153, 6594.472442204708, 6821.863562728817, 7250.854982900418, 7340.889886651597, 7499.212582678959, 6696.0, 8249.958750206211, 8284.0, 8319.792005199919, 8321.95975503062, 7236.240194779472, 7331.8533629328185, 7393.223711510214, 7485.989391432305, 7563.697452101855, 7147.928520714726, 7242.203357630762, 7246.202917679157, 7246.782596522113, 7258.237885022208, 6806.149231346082, 6910.965445172742, 6913.75801846933, 6982.720691172296, 6985.860282794417, 4791.808327666854, 4827.348307978378, 4858.319835223142, 4946.258061290835, 4948.307236986752, 4809.543093406261, 4950.381202349707, 4969.204927211629, 5011.523905228997, 5063.721495317793], "value": 4497.899714512876, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.24547123134624, 305.9128148477684, 310.55900621118036, 312.5343238574523, 320.3576828458941, 5103.468959312206, 5281.260623512701, 5506.834794956148, 5656.547476201899, 5673.943260567393, 4052.298034825373, 5280.1551751719735, 5489.313835770528, 5498.340199176095, 5531.321671088721, 3435.2957643682985, 4212.936805947913, 4228.5982831630945, 4236.521634843621, 4238.936415953764, 3905.668018218455, 4167.729097608661, 4246.2569050416205, 4259.190753756776, 4270.274053410912, 4109.527404348493, 4133.098774563689, 4142.9378559321485, 4156.376543518481, 4171.687123465737, 3248.4640034394415, 3473.947890781628, 3625.981870090659, 4148.91702165958, 4170.562090980434, 2782.5687018512162, 3214.244652506659, 3575.964240357589, 3598.604153543108, 3731.693907132509, 4326.701989403198, 5035.974820125876, 5413.539849112791, 5463.923708990558, 5486.725663716838, 4028.8589899353674, 4818.807247710088, 4831.806727730886, 4834.903301933977, 4853.665242058462, 5883.17635531026, 5889.617174883619, 5913.408659134096, 5928.28860536734, 5939.644580299082, 3489.8080605566684, 3503.3343664703625, 3636.5636123665063, 3799.8790356844797, 3972.245273398045, 6055.909161362583, 6073.817785466443, 6086.179259651327, 6110.450059494622, 6127.6017058891475, 3803.3724435468393, 3895.8831235062994, 4012.578679238638, 4019.7588144711412, 4038.899772118482, 3823.923521529554, 4044.8584299549375, 4055.8174882130374, 4077.918441631151, 4096.180763847243, 4242.639375653042, 4811.735354555533, 4815.0146908916695, 4824.710517368969, 4825.541573550507, 5104.923426148611, 5286.60350473716, 5924.644521328734, 5936.821895343147, 5938.0, 1232.3160645841645, 1248.4007676315418, 1310.7875215425693, 1323.9404226809816, 1326.6815964168723, 765.7587859824138, 781.7029528779027, 883.1698203688512, 903.6837107012625, 903.814717982812, 5201.0, 5275.575594589516, 5298.682079075268, 5305.445351614428, 5308.708021058802, 5355.259540649226, 5466.863328416742, 5562.969516126665, 5698.772049118072, 5766.116941529235, 4933.531314525115, 5129.717865517432, 5265.341832270966, 5272.6836389816735, 5282.471752824764, 2681.6647919010124, 2722.7821774258014, 2844.615976843141, 2940.6324209473814, 3022.871328175328, 4850.216830871926, 4957.752112394366, 5277.736113194325, 5566.882545774299, 5847.619904706181, 4788.760561971888, 5137.40919794221, 5164.225366195025, 5718.79984200551, 5882.294124704978, 5118.513741194581, 5488.890222195534, 5555.0, 5780.335261444903, 5921.319048309413, 5401.519921079058, 5722.685252311163, 5768.0, 5778.94221057784, 5780.68772491007, 4953.1579631463455, 5136.512031357015, 5441.7551210196425, 5568.888622227451, 5634.4365563443325, 5012.824551140692, 5612.456574441898, 5830.183774271521, 5848.970755146197, 5914.822555323347, 3181.8045548571413, 3252.804831710105, 3802.821125451119, 3834.712396570324, 3837.333053527883, 5703.857403564944, 5839.591228613956, 5873.882522349614, 6088.056351265561, 6107.236595425572, 5066.41736200327, 5885.705714714161, 5956.553258505716, 5977.820665379872, 5988.341282458839, 5978.461938425563, 5983.162357270073, 6006.549508786771, 6008.24896887889, 6049.969750151221, 4648.372469716545, 5381.892362152813, 5848.0350742127075, 5849.572427442564, 5874.618149820248, 4798.992211635596, 5320.078926992439, 5554.167374638882, 5939.753076550287, 5980.641161530322, 4893.877653058702, 5372.2747429098135, 5815.5929084963645, 5852.297724273115, 5887.52899768009], "value": 4142.765719083166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.9295523969986, 724.3082855872642, 725.7568714480649, 730.5288089182477, 751.1849643137195, 11484.540618375255, 13058.673533161664, 14476.782848257271, 14788.0, 14883.851161488381, 10594.78810423791, 11002.284851484648, 13422.66443338917, 13467.595972120827, 13719.245441500714, 711.8647456983157, 809.182725447298, 827.4993628854546, 827.6192951242435, 830.3813658824184, 649.6913965866199, 675.3584095109666, 700.8002719225021, 807.9151689072651, 827.0571548434789, 866.7053201911349, 877.5656050255101, 878.4114643189047, 880.0978996528578, 881.4358810361374, 854.9572521373907, 857.6355049104137, 876.3996662286354, 877.1929824561419, 878.6265837019305, 625.9499240060784, 634.3307810260173, 651.501601275025, 651.5862427358614, 652.4877970792904, 14486.058406203563, 14487.275636218146, 14574.417023319054, 14664.193469359181, 14714.926425367912, 11760.470778814974, 13648.317584120754, 13872.306384680725, 13995.650108747363, 14031.298435078204, 11136.61021864239, 11537.134714896332, 11643.01034412076, 11651.417429128509, 11988.520459181622, 3209.646938836726, 3656.451532270154, 3698.0385099873956, 3738.3644780387126, 3834.405667121601, 96203.51898240464, 97143.51428242885, 97240.0, 98746.0, 99202.0, 9627.470489123025, 9856.655017074512, 10462.895371046345, 10805.973432524055, 10911.618093366853, 20962.685559716618, 21189.89405052965, 21378.0, 21395.786042139378, 21712.674309885366, 7769.883451748228, 7798.415118866108, 7799.45403821727, 7873.921260787433, 7947.682092716226, 4124.8143833527565, 4164.167166566699, 4238.321868501025, 4284.378765079046, 4350.129974005212, 3296.4396052671104, 3394.6096198936943, 3398.04854640701, 3402.778819376782, 3404.2340473393288, 602.2261394108549, 630.908518264849, 639.0829160155192, 639.9552031357761, 647.1134545672459, 604.4439116013278, 616.8581226317972, 618.4990157971968, 618.7246675229479, 628.833359159823, 8246.54643994586, 8821.692489869774, 8888.60001299943, 8985.19133277995, 9061.728148155566, 591.7189335065896, 596.9343372229051, 614.5513774944226, 617.163743128064, 629.858281886581, 4091.243120022805, 4340.175366680321, 4354.804033818486, 4357.3899654048455, 4454.7549884756, 71099.0, 78333.60833195911, 100081.4987775184, 102886.48556757168, 125588.37205814096, 95868.0, 98488.50755746175, 98694.51958220633, 100808.0, 102138.48930755298, 88532.11467885367, 90852.82770255062, 90903.09096909079, 93345.0, 93576.0, 9313.0, 9509.429434233969, 9873.95063024709, 9884.25868059884, 9888.060634239735, 35925.82037089798, 54035.189472157166, 55739.72130139486, 56120.5969850757, 57953.0, 68263.65868170628, 68617.65691171512, 78239.60880195562, 84336.0, 85321.0, 12271.325077120844, 12563.0, 12775.041871859834, 12814.743705126031, 12911.0, 14150.858491415365, 14228.217448040457, 14378.496752613608, 14474.638134046732, 14518.346674399889, 13034.869651303365, 13226.4048117833, 13448.596542103753, 13497.055206135476, 13560.45758169662, 12461.93769031149, 13039.087263891437, 13162.736745265232, 13637.522686705917, 13676.521321753691, 12657.39788695652, 13025.218486890439, 13204.207747535178, 13349.466021359036, 13574.0, 10573.418461984666, 10885.0, 11230.3261804292, 11460.426978651201, 11670.70823229426, 11416.543338266376, 11428.885711142782, 11444.542218311175, 11491.367974761133, 11767.88232117668], "value": 7295.420199689441, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 119.0, 121.0, 173.0, 171.0, 167.0, 101.0, 173.0, 176.0], "value": 142.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 128.0, 180.0, 112.0, 115.0, 118.0, 118.0, 152.0, 142.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 196.0, 195.0, 202.0, 198.0, 195.0, 196.0, 198.0, 196.0, 196.0], "value": 196.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 61.0, 88.0, 62.0, 59.0, 60.0, 60.0, 69.0, 60.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 71.0, 91.0, 72.0, 69.0, 70.0, 86.0, 68.0, 72.0, 88.0], "value": 81.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 76.0, 133.0, 128.0, 136.0, 132.0, 137.0, 85.0, 102.0, 131.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 99.0, 98.0, 115.0, 148.0, 170.0, 100.0, 99.0, 102.0], "value": 113.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 86.0, 87.0, 91.0, 94.0, 90.0, 97.0, 89.0, 91.0], "value": 91.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 67.0, 92.0, 93.0, 92.0, 93.0, 87.0, 61.0], "value": 75.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 78.0, 98.0, 92.0, 101.0, 104.0, 80.0, 75.0, 73.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 85.0, 84.0, 87.0, 85.0, 87.0, 97.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 151.0, 163.0, 166.0, 153.0, 153.0, 154.0, 199.0, 167.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 170.0, 170.0, 168.0, 171.0, 172.0, 170.0, 170.0, 168.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 67.0, 70.0, 67.0, 67.0, 70.0, 67.0, 69.0], "value": 68.3, "unit": "score"}]}]} 03:49:08 INFO - Return code: 0 03:49:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:08 ERROR - # TBPL SUCCESS # 03:49:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:49:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:49:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:49:08 INFO - 2016-11-27 03:49:08.864 screenresolution[2249:42769] starting screenresolution argv=screenresolution get 03:49:08 INFO - 2016-11-27 03:49:08.867 screenresolution[2249:42769] Display 0: 1600x1200x32@60 03:49:08 INFO - 2016-11-27 03:49:08.873 screenresolution[2250:42772] starting screenresolution argv=screenresolution list 03:49:08 INFO - Available Modes on Display 0 03:49:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:49:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:49:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:49:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:49:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:49:09 INFO - Intel Iris: 03:49:09 INFO - Chipset Model: Intel Iris 03:49:09 INFO - Type: GPU 03:49:09 INFO - Bus: Built-In 03:49:09 INFO - VRAM (Dynamic, Max): 1536 MB 03:49:09 INFO - Vendor: Intel (0x8086) 03:49:09 INFO - Device ID: 0x0a2e 03:49:09 INFO - Revision ID: 0x0009 03:49:09 INFO - Displays: 03:49:09 INFO - Display: 03:49:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:49:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:49:09 INFO - Display Serial Number: 1600x1200 60 03:49:09 INFO - Main Display: Yes 03:49:09 INFO - Mirror: Off 03:49:09 INFO - Online: Yes 03:49:09 INFO - Rotation: Supported 03:49:09 INFO - Return code: 0 03:49:09 INFO - Running post-action listener: _resource_record_post_action 03:49:09 INFO - [mozharness: 2016-11-27 11:49:09.122676Z] Finished run-tests step (success) 03:49:09 INFO - Running post-run listener: _resource_record_post_run 03:49:09 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 385024; Write bytes: 662520832; Read time: 4; Write time: 1956 03:49:09 INFO - TinderboxPrint: CPU usage
54.4% 03:49:09 INFO - TinderboxPrint: I/O read bytes / time
385,024 / 4 03:49:09 INFO - TinderboxPrint: I/O write bytes / time
662,520,832 / 1,956 03:49:09 INFO - TinderboxPrint: CPU idle
2,207.8 (45.6%) 03:49:09 INFO - TinderboxPrint: CPU system
980.0 (20.2%) 03:49:09 INFO - TinderboxPrint: CPU user
1,653.9 (34.2%) 03:49:09 INFO - TinderboxPrint: Swap in / out
348,225,536 / 0 03:49:09 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 349096448; Write bytes: 351045120; Read time: 26823; Write time: 770 03:49:09 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 262144; Write bytes: 310132224; Read time: 2; Write time: 1177 03:49:09 INFO - Running post-run listener: _upload_blobber_files 03:49:09 INFO - Blob upload gear active. 03:49:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:09 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 03:49:09 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'] 03:49:09 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 03:49:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:11 INFO - (blobuploader) - INFO - Done attempting. 03:49:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:12 INFO - (blobuploader) - INFO - Done attempting. 03:49:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:14 INFO - (blobuploader) - INFO - Done attempting. 03:49:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:14 INFO - Return code: 0 03:49:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fbff5b0f850ce02c4d681ccca24322535d49a69e886dfbfbe37f8507fb9e966a235d8caaa65b1849f3def4303b384e396b28aae108cc1d54420689b324d3481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c55fc6d0ba567fb0d9f072d7c7ddc9b24e6ff868f6c99cefae87c5d89fdcc0afe01ee5017a01dda19ed9ff80c9bc5dabdfdd92b2192d55ac55c3366c2c76bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d258358c1fe44cbb2858b7248d56e27879d9dabf85806c57bd78984ba7c1d81b13441ccc421be0f747ea7e216d98fc0e70b5a86f90e4ac3dc9f2ad62f7362d4"} 03:49:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:14 INFO - Contents: 03:49:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7fbff5b0f850ce02c4d681ccca24322535d49a69e886dfbfbe37f8507fb9e966a235d8caaa65b1849f3def4303b384e396b28aae108cc1d54420689b324d3481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c55fc6d0ba567fb0d9f072d7c7ddc9b24e6ff868f6c99cefae87c5d89fdcc0afe01ee5017a01dda19ed9ff80c9bc5dabdfdd92b2192d55ac55c3366c2c76bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d258358c1fe44cbb2858b7248d56e27879d9dabf85806c57bd78984ba7c1d81b13441ccc421be0f747ea7e216d98fc0e70b5a86f90e4ac3dc9f2ad62f7362d4"} 03:49:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:14 INFO - Copying logs to upload dir... 03:49:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.236279 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-27 03:49:14.589087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 03:49:14.592370) ========= 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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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/7fbff5b0f850ce02c4d681ccca24322535d49a69e886dfbfbe37f8507fb9e966a235d8caaa65b1849f3def4303b384e396b28aae108cc1d54420689b324d3481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c55fc6d0ba567fb0d9f072d7c7ddc9b24e6ff868f6c99cefae87c5d89fdcc0afe01ee5017a01dda19ed9ff80c9bc5dabdfdd92b2192d55ac55c3366c2c76bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d258358c1fe44cbb2858b7248d56e27879d9dabf85806c57bd78984ba7c1d81b13441ccc421be0f747ea7e216d98fc0e70b5a86f90e4ac3dc9f2ad62f7362d4"} build_url:https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/S8kkFjJiQOmFh9Gcp_3iZg/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/7fbff5b0f850ce02c4d681ccca24322535d49a69e886dfbfbe37f8507fb9e966a235d8caaa65b1849f3def4303b384e396b28aae108cc1d54420689b324d3481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c55fc6d0ba567fb0d9f072d7c7ddc9b24e6ff868f6c99cefae87c5d89fdcc0afe01ee5017a01dda19ed9ff80c9bc5dabdfdd92b2192d55ac55c3366c2c76bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d258358c1fe44cbb2858b7248d56e27879d9dabf85806c57bd78984ba7c1d81b13441ccc421be0f747ea7e216d98fc0e70b5a86f90e4ac3dc9f2ad62f7362d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-27 03:49:14.625499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 03:49:14.625789) ========= 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.TnIRJBFy0w/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.2ORDJrtsnW/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005291 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-27 03:49:14.673310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 03:49:14.673595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-27 03:49:14.673874) ========= ========= Total master_lag: 0.18 =========