builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0185 starttime: 1476785434.82 results: success (0) buildid: 20161018004015 builduid: 06626141ff224aea9bb416dd66c1b2a2 revision: be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:34.820593) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:34.821010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:34.821282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:34.964264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:34.964516) ========= 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.aqltpPO8TX/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.9cQpgNFxXk/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-10-18 03:10:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-10-18 03:10:35 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.489375 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:35.480798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:35.481113) ========= 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.aqltpPO8TX/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.9cQpgNFxXk/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.028935 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:35.530611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 03:10:35.530922) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea --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 be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aqltpPO8TX/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.9cQpgNFxXk/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-10-18 03:10:35,605 truncating revision to first 12 chars 2016-10-18 03:10:35,605 Setting DEBUG logging. 2016-10-18 03:10:35,605 attempt 1/10 2016-10-18 03:10:35,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/be9b2b04f7e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 03:10:36,908 unpacking tar archive at: mozilla-aurora-be9b2b04f7e3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.563446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 03:10:37.116238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:37.116637) ========= script_repo_revision: be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:37.117031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:37.117297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 03:10:37.135027) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-18 03:10:37.135387) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.aqltpPO8TX/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.9cQpgNFxXk/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:10:37 INFO - MultiFileLogger online at 20161018 03:10:37 in /builds/slave/test 03:10:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:10:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:10:37 INFO - {'append_to_log': False, 03:10:37 INFO - 'base_work_dir': '/builds/slave/test', 03:10:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:10:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:10:37 INFO - 'branch': 'Mozilla-Aurora', 03:10:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:10:37 INFO - 'config_files': ('talos/mac_config.py',), 03:10:37 INFO - 'default_actions': ('clobber', 03:10:37 INFO - 'read-buildbot-config', 03:10:37 INFO - 'download-and-extract', 03:10:37 INFO - 'populate-webroot', 03:10:37 INFO - 'create-virtualenv', 03:10:37 INFO - 'install', 03:10:37 INFO - 'run-tests'), 03:10:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:10:37 INFO - 'download_minidump_stackwalk': True, 03:10:37 INFO - 'download_symbols': 'ondemand', 03:10:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:10:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:10:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:10:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:10:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:10:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:10:37 INFO - 'installer_path': 'installer.exe', 03:10:37 INFO - 'log_level': 'info', 03:10:37 INFO - 'log_name': 'talos', 03:10:37 INFO - 'log_to_console': True, 03:10:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:10:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:10:37 INFO - 'opt_config_files': (), 03:10:37 INFO - 'pip_index': False, 03:10:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:10:37 INFO - 'cmd': ('bash', 03:10:37 INFO - '-c', 03:10:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:10:37 INFO - 'enabled': True, 03:10:37 INFO - 'halt_on_failure': False, 03:10:37 INFO - 'name': 'check_screen_resolution'},), 03:10:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:10:37 INFO - 'cmd': ('bash', 03:10:37 INFO - '-c', 03:10:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:10:37 INFO - 'enabled': True, 03:10:37 INFO - 'halt_on_failure': False, 03:10:37 INFO - 'name': 'check_screen_resolution'},), 03:10:37 INFO - 'run_cmd_checks_enabled': True, 03:10:37 INFO - 'sps_profile': False, 03:10:37 INFO - 'sps_profile_interval': 0, 03:10:37 INFO - 'suite': 'dromaeojs', 03:10:37 INFO - 'system_bits': '32', 03:10:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:10:37 INFO - 'title': 't-yosemite-r7-0185', 03:10:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:10:37 INFO - 'use_talos_json': True, 03:10:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:10:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:10:37 INFO - 'work_dir': 'build'} 03:10:37 INFO - [mozharness: 2016-10-18 10:10:37.332634Z] Running clobber step. 03:10:37 INFO - Running pre-action listener: _resource_record_pre_action 03:10:37 INFO - Running main action method: clobber 03:10:37 INFO - rmtree: /builds/slave/test/build 03:10:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:10:39 INFO - Running post-action listener: _resource_record_post_action 03:10:39 INFO - [mozharness: 2016-10-18 10:10:39.415267Z] Finished clobber step (success) 03:10:39 INFO - [mozharness: 2016-10-18 10:10:39.415404Z] Running read-buildbot-config step. 03:10:39 INFO - Running pre-action listener: _resource_record_pre_action 03:10:39 INFO - Running main action method: read_buildbot_config 03:10:39 INFO - Using buildbot properties: 03:10:39 INFO - { 03:10:39 INFO - "project": "", 03:10:39 INFO - "product": "firefox", 03:10:39 INFO - "script_repo_revision": "production", 03:10:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:10:39 INFO - "repository": "", 03:10:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:10:39 INFO - "buildid": "20161018004015", 03:10:39 INFO - "stage_platform": "macosx64", 03:10:39 INFO - "basedir": "/builds/slave/test", 03:10:39 INFO - "nightly_build": "True", 03:10:39 INFO - "buildnumber": 3, 03:10:39 INFO - "slavename": "t-yosemite-r7-0185", 03:10:39 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:10:39 INFO - "platform": "yosemite_r7", 03:10:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:10:39 INFO - "branch": "mozilla-aurora", 03:10:39 INFO - "repo_path": "releases/mozilla-aurora", 03:10:39 INFO - "revision": "be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea", 03:10:39 INFO - "pgo_build": "False", 03:10:39 INFO - "builduid": "06626141ff224aea9bb416dd66c1b2a2", 03:10:39 INFO - "slavebuilddir": "test" 03:10:39 INFO - } 03:10:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:10:39 INFO - Running post-action listener: _resource_record_post_action 03:10:39 INFO - [mozharness: 2016-10-18 10:10:39.418729Z] Finished read-buildbot-config step (success) 03:10:39 INFO - [mozharness: 2016-10-18 10:10:39.418881Z] Running download-and-extract step. 03:10:39 INFO - Running pre-action listener: _resource_record_pre_action 03:10:39 INFO - Running main action method: download_and_extract 03:10:39 INFO - mkdir: /builds/slave/test/build/tests 03:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:39 INFO - trying https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:10:39 INFO - Downloading https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:10:40 INFO - Downloaded 1199 bytes. 03:10:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:10:40 INFO - Using the following test package requirements: 03:10:40 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:10:40 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:10:40 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:10:40 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'jsshell-mac.zip'], 03:10:40 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:10:40 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:10:40 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:10:40 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:10:40 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:10:40 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:10:40 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:10:40 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:10:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:10:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:10:40 INFO - Fetch https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:10:40 INFO - Expected file size: 16435444 03:10:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:10:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:10:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:10:47 INFO - Fetch https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:10:48 INFO - Expected file size: 16435444 03:10:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:10:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:10:55 INFO - Fetch https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:10:56 INFO - Expected file size: 14414081 03:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:10:56 INFO - trying https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:10:56 INFO - Downloading https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:10:59 INFO - Downloaded 115583759 bytes. 03:10:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:10:59 INFO - mkdir: /builds/slave/test/properties 03:10:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:59 INFO - Contents: 03:10:59 INFO - build_url:https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:00 INFO - Running post-action listener: _resource_record_post_action 03:11:00 INFO - Running post-action listener: set_extra_try_arguments 03:11:00 INFO - [mozharness: 2016-10-18 10:11:00.491911Z] Finished download-and-extract step (success) 03:11:00 INFO - [mozharness: 2016-10-18 10:11:00.492027Z] Running populate-webroot step. 03:11:00 INFO - Running pre-action listener: _resource_record_pre_action 03:11:00 INFO - Running main action method: populate_webroot 03:11:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:00 INFO - '--tppagecycles', 03:11:00 INFO - '7'], 03:11:00 INFO - 'tests': ['tsvgm']}}, 03:11:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['damp', 'tps']}, 03:11:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'tests': ['damp', 'tps']}, 03:11:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['dromaeo_dom']}, 03:11:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['basic_compositor_video']}, 03:11:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:11:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['a11yr', 03:11:00 INFO - 'ts_paint', 03:11:00 INFO - 'tpaint', 03:11:00 INFO - 'sessionrestore', 03:11:00 INFO - 'sessionrestore_no_auto_restore', 03:11:00 INFO - 'tabpaint']}, 03:11:00 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:00 INFO - 'ts_paint', 03:11:00 INFO - 'tpaint', 03:11:00 INFO - 'sessionrestore', 03:11:00 INFO - 'sessionrestore_no_auto_restore', 03:11:00 INFO - 'tabpaint']}, 03:11:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:00 INFO - 'ts_paint', 03:11:00 INFO - 'tpaint', 03:11:00 INFO - 'sessionrestore', 03:11:00 INFO - 'sessionrestore_no_auto_restore', 03:11:00 INFO - 'tabpaint']}, 03:11:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:00 INFO - 'ts_paint', 03:11:00 INFO - 'tpaint', 03:11:00 INFO - 'sessionrestore', 03:11:00 INFO - 'sessionrestore_no_auto_restore', 03:11:00 INFO - 'tabpaint']}, 03:11:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['a11yr', 03:11:00 INFO - 'ts_paint', 03:11:00 INFO - 'tpaint', 03:11:00 INFO - 'sessionrestore', 03:11:00 INFO - 'sessionrestore_no_auto_restore', 03:11:00 INFO - 'tabpaint']}, 03:11:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['a11yr', 03:11:00 INFO - 'ts_paint', 03:11:00 INFO - 'tpaint', 03:11:00 INFO - 'sessionrestore', 03:11:00 INFO - 'sessionrestore_no_auto_restore', 03:11:00 INFO - 'tabpaint']}, 03:11:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['tsvgx', 03:11:00 INFO - 'tsvgr_opacity', 03:11:00 INFO - 'tart', 03:11:00 INFO - 'tscrollx', 03:11:00 INFO - 'cart']}, 03:11:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:00 INFO - 'tsvgr_opacity', 03:11:00 INFO - 'tart', 03:11:00 INFO - 'tscrollx', 03:11:00 INFO - 'cart']}, 03:11:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'talos_options': ['--disable-e10s'], 03:11:00 INFO - 'tests': ['tp5o']}, 03:11:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'tests': ['tp5o']}, 03:11:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'talos_options': ['--disable-e10s', 03:11:00 INFO - '--xperf_path', 03:11:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:00 INFO - 'tests': ['tp5n']}, 03:11:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:00 INFO - 'talos_options': ['--xperf_path', 03:11:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:00 INFO - 'tests': ['tp5n']}}, 03:11:00 INFO - 'talos.zip': {'path': '', 03:11:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:00 INFO - Running post-action listener: _resource_record_post_action 03:11:00 INFO - [mozharness: 2016-10-18 10:11:00.510469Z] Finished populate-webroot step (success) 03:11:00 INFO - [mozharness: 2016-10-18 10:11:00.510598Z] Running create-virtualenv step. 03:11:00 INFO - Running pre-action listener: _resource_record_pre_action 03:11:00 INFO - Running main action method: create_virtualenv 03:11:00 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:00 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:11:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:00 INFO - Using real prefix '/tools/python27' 03:11:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:04 INFO - Installing pip.................done. 03:11:04 INFO - Return code: 0 03:11:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11: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:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:04 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:04 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:11:04 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:11:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:04 INFO - 'HOME': '/Users/cltbld', 03:11:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:04 INFO - 'LOGNAME': 'cltbld', 03:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:04 INFO - 'MOZ_NO_REMOTE': '1', 03:11:04 INFO - 'NO_EM_RESTART': '1', 03:11:04 INFO - 'PAGER': '/bin/cat', 03:11:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:04 INFO - 'PWD': '/builds/slave/test', 03:11:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:04 INFO - 'SHELL': '/bin/bash', 03:11:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:04 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:04 INFO - 'USER': 'cltbld', 03:11:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:04 INFO - 'XPC_FLAGS': '0x0', 03:11:04 INFO - 'XPC_SERVICE_NAME': '0', 03:11:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:04 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:11:04 INFO - Cleaning up... 03:11:04 INFO - Return code: 0 03:11:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:11: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:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:04 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:04 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:11:04 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:11:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:04 INFO - 'HOME': '/Users/cltbld', 03:11:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:04 INFO - 'LOGNAME': 'cltbld', 03:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:04 INFO - 'MOZ_NO_REMOTE': '1', 03:11:04 INFO - 'NO_EM_RESTART': '1', 03:11:04 INFO - 'PAGER': '/bin/cat', 03:11:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:04 INFO - 'PWD': '/builds/slave/test', 03:11:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:04 INFO - 'SHELL': '/bin/bash', 03:11:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:04 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:04 INFO - 'USER': 'cltbld', 03:11:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:04 INFO - 'XPC_FLAGS': '0x0', 03:11:04 INFO - 'XPC_SERVICE_NAME': '0', 03:11:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:04 INFO - Downloading/unpacking psutil>=3.1.1 03:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:08 INFO - Installing collected packages: psutil 03:11:08 INFO - Running setup.py install for psutil 03:11:08 INFO - building 'psutil._psutil_osx' extension 03:11:08 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:11:09 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:11:09 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:11:09 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:11:09 INFO - building 'psutil._psutil_posix' extension 03:11:09 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:11:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:11:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:11:09 INFO - ^ 03:11:09 INFO - 1 warning generated. 03:11:09 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:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:09 INFO - Successfully installed psutil 03:11:09 INFO - Cleaning up... 03:11:10 INFO - Return code: 0 03:11:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:10 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:10 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:11:10 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:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:10 INFO - 'HOME': '/Users/cltbld', 03:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:10 INFO - 'LOGNAME': 'cltbld', 03:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:10 INFO - 'MOZ_NO_REMOTE': '1', 03:11:10 INFO - 'NO_EM_RESTART': '1', 03:11:10 INFO - 'PAGER': '/bin/cat', 03:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:10 INFO - 'PWD': '/builds/slave/test', 03:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:10 INFO - 'SHELL': '/bin/bash', 03:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:10 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:10 INFO - 'USER': 'cltbld', 03:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:10 INFO - 'XPC_FLAGS': '0x0', 03:11:10 INFO - 'XPC_SERVICE_NAME': '0', 03:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:11:12 INFO - Installing collected packages: mozsystemmonitor 03:11:12 INFO - Running setup.py install for mozsystemmonitor 03:11:13 INFO - Successfully installed mozsystemmonitor 03:11:13 INFO - Cleaning up... 03:11:13 INFO - Return code: 0 03:11:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:13 INFO - 'HOME': '/Users/cltbld', 03:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:13 INFO - 'LOGNAME': 'cltbld', 03:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:13 INFO - 'MOZ_NO_REMOTE': '1', 03:11:13 INFO - 'NO_EM_RESTART': '1', 03:11:13 INFO - 'PAGER': '/bin/cat', 03:11:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:13 INFO - 'PWD': '/builds/slave/test', 03:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:13 INFO - 'SHELL': '/bin/bash', 03:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:13 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:13 INFO - 'USER': 'cltbld', 03:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:13 INFO - 'XPC_FLAGS': '0x0', 03:11:13 INFO - 'XPC_SERVICE_NAME': '0', 03:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:11:15 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:11:15 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:11:15 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:11:15 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:11:15 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:11:15 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:11:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:16 INFO - warning: no files found matching '*.txt' 03:11:16 INFO - no previously-included directories found matching 'build' 03:11:16 INFO - no previously-included directories found matching 'dist' 03:11:16 INFO - no previously-included directories found matching '.git*' 03:11:16 INFO - Installing collected packages: jsonschema, functools32 03:11:16 INFO - Running setup.py install for functools32 03:11:16 INFO - warning: no files found matching '*.txt' 03:11:16 INFO - no previously-included directories found matching 'build' 03:11:16 INFO - no previously-included directories found matching 'dist' 03:11:16 INFO - no previously-included directories found matching '.git*' 03:11:16 INFO - Successfully installed jsonschema functools32 03:11:16 INFO - Cleaning up... 03:11:16 INFO - Return code: 0 03:11:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:16 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:16 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:11:16 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:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:16 INFO - 'HOME': '/Users/cltbld', 03:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:16 INFO - 'LOGNAME': 'cltbld', 03:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:16 INFO - 'MOZ_NO_REMOTE': '1', 03:11:16 INFO - 'NO_EM_RESTART': '1', 03:11:16 INFO - 'PAGER': '/bin/cat', 03:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:16 INFO - 'PWD': '/builds/slave/test', 03:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:16 INFO - 'SHELL': '/bin/bash', 03:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:16 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:16 INFO - 'USER': 'cltbld', 03:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:16 INFO - 'XPC_FLAGS': '0x0', 03:11:16 INFO - 'XPC_SERVICE_NAME': '0', 03:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:11:16 INFO - Cleaning up... 03:11:16 INFO - Return code: 0 03:11:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:16 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:16 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:11:16 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:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:16 INFO - 'HOME': '/Users/cltbld', 03:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:16 INFO - 'LOGNAME': 'cltbld', 03:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:16 INFO - 'MOZ_NO_REMOTE': '1', 03:11:16 INFO - 'NO_EM_RESTART': '1', 03:11:16 INFO - 'PAGER': '/bin/cat', 03:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:16 INFO - 'PWD': '/builds/slave/test', 03:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:16 INFO - 'SHELL': '/bin/bash', 03:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:16 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:16 INFO - 'USER': 'cltbld', 03:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:16 INFO - 'XPC_FLAGS': '0x0', 03:11:16 INFO - 'XPC_SERVICE_NAME': '0', 03:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:17 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:11:17 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:11:17 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:11:17 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:11:17 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:11:17 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:11:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:20 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:11:20 INFO - Downloading docopt-0.6.1.tar.gz 03:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:20 INFO - Running setup.py install for blobuploader 03:11:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:21 INFO - Running setup.py install for requests 03:11:21 INFO - Running setup.py install for docopt 03:11:21 INFO - Successfully installed blobuploader requests docopt 03:11:21 INFO - Cleaning up... 03:11:21 INFO - Return code: 0 03:11:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11: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:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:21 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:11:21 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:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:21 INFO - 'HOME': '/Users/cltbld', 03:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:21 INFO - 'LOGNAME': 'cltbld', 03:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:21 INFO - 'MOZ_NO_REMOTE': '1', 03:11:21 INFO - 'NO_EM_RESTART': '1', 03:11:21 INFO - 'PAGER': '/bin/cat', 03:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:21 INFO - 'PWD': '/builds/slave/test', 03:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:21 INFO - 'SHELL': '/bin/bash', 03:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:21 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:21 INFO - 'USER': 'cltbld', 03:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:21 INFO - 'XPC_FLAGS': '0x0', 03:11:21 INFO - 'XPC_SERVICE_NAME': '0', 03:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-hbBddg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-K8uYMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rE3raQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-GZ94pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-m7cuGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-MPE1V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-IWyacA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9AzqmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:22 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-VWQydX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-hLqRL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-KsmnfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-qxTeLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-1AgxkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Ko0lHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-w5Vrrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-x6EzcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:23 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-EXkrmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:23 INFO - Running setup.py install for manifestparser 03:11:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:11:24 INFO - Running setup.py install for mozcrash 03:11:24 INFO - Running setup.py install for mozdebug 03:11:24 INFO - Running setup.py install for mozdevice 03:11:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:11:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:11:24 INFO - Running setup.py install for mozfile 03:11:24 INFO - Running setup.py install for mozhttpd 03:11:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:11:24 INFO - Running setup.py install for mozinfo 03:11:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:11:24 INFO - Running setup.py install for mozInstall 03:11:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Running setup.py install for mozleak 03:11:25 INFO - Running setup.py install for mozlog 03:11:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Running setup.py install for moznetwork 03:11:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Running setup.py install for mozprocess 03:11:25 INFO - Running setup.py install for mozprofile 03:11:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:11:25 INFO - Running setup.py install for mozrunner 03:11:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:11:26 INFO - Running setup.py install for mozscreenshot 03:11:26 INFO - Running setup.py install for moztest 03:11:26 INFO - Running setup.py install for mozversion 03:11:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:11:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:26 INFO - Cleaning up... 03:11:26 INFO - Return code: 0 03:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:26 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:11:26 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:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:26 INFO - 'HOME': '/Users/cltbld', 03:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:26 INFO - 'LOGNAME': 'cltbld', 03:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:26 INFO - 'MOZ_NO_REMOTE': '1', 03:11:26 INFO - 'NO_EM_RESTART': '1', 03:11:26 INFO - 'PAGER': '/bin/cat', 03:11:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:26 INFO - 'PWD': '/builds/slave/test', 03:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:26 INFO - 'SHELL': '/bin/bash', 03:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:26 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:26 INFO - 'USER': 'cltbld', 03:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:26 INFO - 'XPC_FLAGS': '0x0', 03:11:26 INFO - 'XPC_SERVICE_NAME': '0', 03:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:26 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-sEMMxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:26 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:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:26 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-EgvKOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:26 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-5CgXAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-YVva48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-zMeOuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-QEDs1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Wc2ZY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ORAMIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ix8drr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-M1ATCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-s9PFlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:27 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-xAuT1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:27 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:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:28 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Ix3upu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:28 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:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:28 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-i3v1XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:28 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-lFEAt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:28 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:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:28 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-WWi1Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:28 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:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:28 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rbwk9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:28 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:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:28 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:11:28 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:11:28 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:11:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:28 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:11:28 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:11:28 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:11:28 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:11:28 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:11:28 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:11:31 INFO - Downloading blessings-1.6.tar.gz 03:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:31 INFO - Installing collected packages: blessings 03:11:31 INFO - Running setup.py install for blessings 03:11:31 INFO - Successfully installed blessings 03:11:31 INFO - Cleaning up... 03:11:31 INFO - Return code: 0 03:11:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:11:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:31 INFO - Reading from file tmpfile_stdout 03:11:31 INFO - Current package versions: 03:11:31 INFO - blessings == 1.6 03:11:31 INFO - blobuploader == 1.2.4 03:11:31 INFO - docopt == 0.6.1 03:11:31 INFO - functools32 == 3.2.3-2 03:11:31 INFO - jsonschema == 2.5.1 03:11:31 INFO - manifestparser == 1.1 03:11:31 INFO - mozInstall == 1.12 03:11:31 INFO - mozcrash == 0.17 03:11:31 INFO - mozdebug == 0.1 03:11:31 INFO - mozdevice == 0.48 03:11:31 INFO - mozfile == 1.2 03:11:31 INFO - mozhttpd == 0.7 03:11:31 INFO - mozinfo == 0.9 03:11:31 INFO - mozleak == 0.1 03:11:31 INFO - mozlog == 3.4 03:11:31 INFO - moznetwork == 0.27 03:11:31 INFO - mozprocess == 0.23 03:11:31 INFO - mozprofile == 0.28 03:11:31 INFO - mozrunner == 6.12 03:11:31 INFO - mozscreenshot == 0.1 03:11:31 INFO - mozsystemmonitor == 0.3 03:11:31 INFO - moztest == 0.7 03:11:31 INFO - mozversion == 1.4 03:11:31 INFO - psutil == 3.1.1 03:11:31 INFO - requests == 1.2.3 03:11:31 INFO - wsgiref == 0.1.2 03:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:31 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:11:31 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:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:31 INFO - 'HOME': '/Users/cltbld', 03:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:31 INFO - 'LOGNAME': 'cltbld', 03:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:31 INFO - 'MOZ_NO_REMOTE': '1', 03:11:31 INFO - 'NO_EM_RESTART': '1', 03:11:31 INFO - 'PAGER': '/bin/cat', 03:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:31 INFO - 'PWD': '/builds/slave/test', 03:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:31 INFO - 'SHELL': '/bin/bash', 03:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:31 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:31 INFO - 'USER': 'cltbld', 03:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:31 INFO - 'XPC_FLAGS': '0x0', 03:11:31 INFO - 'XPC_SERVICE_NAME': '0', 03:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 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:11:31 INFO - Cleaning up... 03:11:31 INFO - Return code: 0 03:11:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 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 0x10af07490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae7d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb223dbd070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, '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.aqltpPO8TX/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.9cQpgNFxXk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:11:31 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:11:31 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:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:31 INFO - 'HOME': '/Users/cltbld', 03:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:31 INFO - 'LOGNAME': 'cltbld', 03:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:31 INFO - 'MOZ_NO_REMOTE': '1', 03:11:31 INFO - 'NO_EM_RESTART': '1', 03:11:31 INFO - 'PAGER': '/bin/cat', 03:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:31 INFO - 'PWD': '/builds/slave/test', 03:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:31 INFO - 'SHELL': '/bin/bash', 03:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:11:31 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:31 INFO - 'USER': 'cltbld', 03:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:31 INFO - 'XPC_FLAGS': '0x0', 03:11:31 INFO - 'XPC_SERVICE_NAME': '0', 03:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:11:32 INFO - Cleaning up... 03:11:32 INFO - Return code: 0 03:11:32 INFO - Running post-action listener: _resource_record_post_action 03:11:32 INFO - Running post-action listener: _start_resource_monitoring 03:11:32 INFO - Starting resource monitoring. 03:11:32 INFO - [mozharness: 2016-10-18 10:11:32.269825Z] Finished create-virtualenv step (success) 03:11:32 INFO - [mozharness: 2016-10-18 10:11:32.270784Z] Running install step. 03:11:32 INFO - Running pre-action listener: _resource_record_pre_action 03:11:32 INFO - Running main action method: install 03:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:32 INFO - Reading from file tmpfile_stdout 03:11:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:32 INFO - Reading from file tmpfile_stdout 03:11:32 INFO - Output received: 03:11:32 INFO - Usage: mozinstall [options] installer 03:11:32 INFO - Options: 03:11:32 INFO - -h, --help show this help message and exit 03:11:32 INFO - -d DEST, --destination=DEST 03:11:32 INFO - Directory to install application into. [default: 03:11:32 INFO - "/builds/slave/test"] 03:11:32 INFO - --app=APP Application being installed. [default: firefox] 03:11:32 INFO - mkdir: /builds/slave/test/build/application 03:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:12:04 INFO - Reading from file tmpfile_stdout 03:12:04 INFO - Output received: 03:12:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:12:04 INFO - Running post-action listener: _resource_record_post_action 03:12:04 INFO - [mozharness: 2016-10-18 10:12:04.686971Z] Finished install step (success) 03:12:04 INFO - [mozharness: 2016-10-18 10:12:04.687120Z] Running run-tests step. 03:12:04 INFO - Running pre-action listener: _resource_record_pre_action 03:12:04 INFO - Running main action method: run_tests 03:12:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:12:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:12:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:12:04 INFO - 2016-10-18 03:12:04.701 screenresolution[1648:8609] starting screenresolution argv=screenresolution get 03:12:04 INFO - 2016-10-18 03:12:04.704 screenresolution[1648:8609] Display 0: 1600x1200x32@60 03:12:04 INFO - 2016-10-18 03:12:04.710 screenresolution[1649:8611] starting screenresolution argv=screenresolution list 03:12:04 INFO - Available Modes on Display 0 03:12:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:12:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:12:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:12:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:12:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:12:04 INFO - Intel Iris: 03:12:04 INFO - Chipset Model: Intel Iris 03:12:04 INFO - Type: GPU 03:12:04 INFO - Bus: Built-In 03:12:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:12:04 INFO - Vendor: Intel (0x8086) 03:12:04 INFO - Device ID: 0x0a2e 03:12:04 INFO - Revision ID: 0x0009 03:12:04 INFO - Displays: 03:12:04 INFO - Display: 03:12:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:12:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:12:04 INFO - Display Serial Number: 1600x1200 60 03:12:04 INFO - Main Display: Yes 03:12:04 INFO - Mirror: Off 03:12:04 INFO - Online: Yes 03:12:04 INFO - Rotation: Supported 03:12:04 INFO - Return code: 0 03:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:04 INFO - Python 2.7.3 03:12:04 INFO - Return code: 0 03:12:04 INFO - grabbing minidump binary from tooltool 03:12: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:12:04 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 0x10ad1bd30>, '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 0x10ab81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad13b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:04 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:12:04 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:12:04 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:12:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:05 INFO - Return code: 0 03:12:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:12:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:12:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:05 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:12:05 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:12:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aqltpPO8TX/Render', 03:12:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:05 INFO - 'HOME': '/Users/cltbld', 03:12:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:05 INFO - 'LOGNAME': 'cltbld', 03:12:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:05 INFO - 'MOZ_NO_REMOTE': '1', 03:12:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:05 INFO - 'NO_EM_RESTART': '1', 03:12:05 INFO - 'PAGER': '/bin/cat', 03:12:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:05 INFO - 'PWD': '/builds/slave/test', 03:12:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:05 INFO - 'SHELL': '/bin/bash', 03:12:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9cQpgNFxXk/Listeners', 03:12:05 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 03:12:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:05 INFO - 'USER': 'cltbld', 03:12:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:05 INFO - 'XPC_FLAGS': '0x0', 03:12:05 INFO - 'XPC_SERVICE_NAME': '0', 03:12:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:12:05 INFO - mozversion application_buildid: 20161018004015 03:12:05 INFO - mozversion application_changeset: be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea 03:12:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:05 INFO - mozversion application_name: Firefox 03:12:05 INFO - mozversion application_remotingname: firefox-dev 03:12:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:05 INFO - mozversion application_vendor: Mozilla 03:12:05 INFO - mozversion application_version: 51.0a2 03:12:05 INFO - mozversion platform_buildid: 20161018004015 03:12:05 INFO - mozversion platform_changeset: be9b2b04f7e3371ab01e3a6d6f1546fdb2fad7ea 03:12:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:05 INFO - mozversion platform_version: 51.0a2 03:12:05 INFO - using testdate: 1476785525 03:12:05 INFO - actual date: 1476785525 03:12:05 INFO - starting webserver on 'localhost:49270' 03:12:05 INFO - SUITE-START | Running 2 tests 03:12:05 INFO - TEST-START | dromaeo_css 03:12:05 INFO - operating with platform_type : mac_ 03:12:05 INFO - Initialising browser for dromaeo_css test... 03:12:05 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpmWJyGH/profile http://localhost:49270/getInfo.html) 03:12:08 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:12:08 INFO - PROCESS | 1659 | colorDepth:24 03:12:08 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:12:08 INFO - PROCESS | 1659 | __metrics 03:12:08 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:12:08 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:09 INFO - TEST-INFO | 1659: exit 0 03:12:09 INFO - Browser initialized. 03:12:09 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:09 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpmWJyGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:21 INFO - PROCESS | 1663 | RSS: Main: 219488256 03:12:21 INFO - PROCESS | 1663 | 03:13:11 INFO - PROCESS | 1663 | 1476785591914 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:15:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 03:15:25 INFO - PROCESS | 1663 | RSS: Main: 322633728 03:15:25 INFO - PROCESS | 1663 | 03:18:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 03:18:28 INFO - PROCESS | 1663 | RSS: Main: 354336768 03:18:28 INFO - PROCESS | 1663 | 03:21:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 03:21:31 INFO - PROCESS | 1663 | RSS: Main: 329027584 03:21:31 INFO - PROCESS | 1663 | 03:24:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 03:24:34 INFO - PROCESS | 1663 | RSS: Main: 319246336 03:24:34 INFO - PROCESS | 1663 | 03:27:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 03:27:38 INFO - PROCESS | 1663 | RSS: Main: 306614272 03:27:38 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 03:30:41 INFO - PROCESS | 1663 | RSS: Main: 499974144 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | __start_tp_report 03:30:41 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 03:30:41 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 03:30:41 INFO - PROCESS | 1663 | |i|pagename|runs| 03:30:41 INFO - PROCESS | 1663 | |0;dojo.html;3347.3807345641053;3351.731861451083;3361.2605226850083;3376.9999999999986;3388.9491657625126;5647.209390685307;5762.250907382045;5763.769449222036;5794.652320860751;5795.043817770068;5732.570057245713;5787.421257874221;5787.913181302284;5800.709964501779;5806.767729290823;5237.973810130953;5258.6318957672975;5270.130428479296;5277.182036784286;5318.069337865877;5209.947900520984;5210.7655155517905;5219.321488206547;5342.893142137155;5349.170878513836;5233.555147812441;5272.393674727398;5289.788408463657;5331.546818520431;5350.759215835277;5252.52727254547;5319.281896943901;5339.225812257201;5341.1988201769655;5351.759170837322;5224.164133738584;5246.344206974129;5273.868153296198;5274.97362513185;5277.70972596507;5618.241537392481;5651.886962260773;5677;5681.772729090872;5702.486776190163;5187.662801917901;6130.979101202072;6170.598911070766;6201.069839524062;6211.968940155315;6197.1324014637985;6224;6234.3453937336835;6248.3751624837605;6266.404691554295;5724.627899186623;5733.226014488074;5771.105478650732;5807.332156802022;5871.765129394819;6276.497880169575;6299.559030867887;6306.9684651576445;6322.36776322364;6327;6159.599626024294;6165.229346331708;6168.9691551542855;6169.56813023093;6173.290071641729;5525.392206857243;5968.820935371946;6142.314611233313;6166.907496387557;6183;6151.815445536641;6222.657753823583;6239.344868788802;6240.5319601030105;6245.375462453719;6165.32181460039;6200.534959878028;6209.348018458088;6228.03465462854;6241.563090583706;4878.707277563358;4923.507649235119;4962.503749625009;4981.153203955337;5001.24981252815;4022.8591999279884;4290.4636920384955;4365.908522869283;4408.074304396113;4467.128909862546;5845.620034697731;5853.443922827325;5881.05903055509;5886.764529418861;5894.67579283135;6269.279032911182;6281.120643109968;6298.8425289367215;6306.653134077578;6315.905261421082;5558.833235002957;5658.179563963202;5668.093105103164;5707.1153971134545;5711.371749107595;5419.6477228980775;5446.319210098738;5460.099083651153;5466.34403871538;5497.285352904097;6354.396332348512;6357.586756860789;6362.745490180341;6364.395382438661;6372.426481616677;6116.457510225689;6212.875742485216;6256.499480041677;6302.023186406114;6304.495640348853;6307.369263073656;6389.361063893573;6400.423961843457;6413.551051426355;6418.903716444163;6273.121762953281;6274.247090349188;6275.309715931153;6276.497880169484;6285.245770507386;6147.9855823788575;6203.503719702323;6237.781677641261;6301.117843501822;6305.211848518935;6038.245219347582;6102.4507794298725;6128.142060111499;6161.907571386522;6229;5989.610675306091;6157.3773763783165;6218.06728990655;6226.25284965807;6232.75068997235;5816.738246778989;5957.851053723692;6034.607750496204;6072.423119803611;6087.786927457518;6063.969680151571;6131.407250743203;6131.866048757656;6136.846578835565;6221.160143380585;6039.728212230372;6043.848903777265;6050.276099914223;6053.697315134137;6058.212432383762 03:30:41 INFO - PROCESS | 1663 | |1;ext.html;461.1215634216818;471.5802935387505;525.9874741123339;533.1420001295486;536.7879687523429;30649.927252546164;40285.39571906424;41363.793181034125;41398.96502587433;41547.16905661885;43115.78442107793;43472.78263608678;43505.7824710876;43548.3467747984;43560;9761.853572196405;9972.252081093911;9976.201903847676;9980;9998;8197.918020819776;8948;11969.640910772647;12219.511219551207;12246.387680615979;12212.267263964146;12282.955948744322;12310.322932238769;12328.19866708661;12374.876251237507;8802.735917922408;12233.63299101024;12288.508459661603;12312.81530777039;12313;8696.869546956801;11814.350210738407;12156.392180391034;12161.331126788024;12373.381330933418;41288.38067428991;41743.58256417427;41747;41783.37324940128;41831;3333.8166400848186;3414.7951122932704;3524.400851855191;3700.3524383232825;3960.0891794887048;25016.4996700065;30547;31652.525212121836;31723.682763172535;31981.360372792646;3148.511980643004;3214.164317277501;3238.87044518219;3251.658575849549;3366.3267346530547;527045;527246.3637681826;527358.3632081853;528142;528533;33366;62786;63159.73680526364;63318.36681633125;63358;34375.65624343775;35389.46915796265;35798;36265.63734362675;36337.90986270416;14947.476838310607;15087.170205638577;15089.849101509064;15096.622584435478;15102.773458398133;11381.260218085798;11571;12714.682132946751;12774.105812593216;12794.296313702836;7816.570088645065;7909.0113735783025;7942.960285198537;8053.234942680436;8108.635111420001;3232.7090561849077;3239.3197428539797;3255.5604993326074;3288.7204587609845;3333.949990750141;895.2927187521915;964.8890377606525;1042.5725452564411;1058.4972138234432;1106.8837772033821;30328.84835575808;30492.847535762623;30763.69236307653;31307.217319567193;31325.843370783456;1050.8003479338902;1053.657561292583;1074.2050882347007;1114.2367478277406;1125.1954852280658;15739.13434761099;15943.441979530893;15968.840311596967;15974.520764377086;16165.515034548982;721794;728602;729931;732665;733042;58615.41384586185;59369.70315148397;59377.81244375175;59398;59514.70242648759;1085.8273065089684;1232.2298563397876;1272.401971073594;1353.032581704106;1381.730562540315;23959.880200598884;28339.319649378278;28466.430671386872;31562.36875262528;31665.575049123305;44852.87867803331;57729.422705774086;58027.4197258022;58041.419585803604;58091.547711307554;666416;674730;674936;675872;677244;26533.7346626539;27432.725672743018;27527;27945.72054279431;28278.86884524596;39132.413013804246;47532;47950.28074578814;48040.75979620079;48621;39625.80187099046;39759.403608946464;39965.40051899166;40040;41850.58149418467;39476.2104757909;39732.40401393924;39932.80033599814;41251.1749765009;41443;36359.636403635624;38579;38593;38636;38719.419208712454;30823;34251.4862277071;35136.29727405387;35164.64835351614;35199.47200792041;21403.67894481553;25213.87393063023;25276.862541185325;25341.239762807145;25797.871010644827 03:30:41 INFO - PROCESS | 1663 | |2;jquery.html;337.10666733157115;369.4790345612687;378.6005763919065;386.4107236464391;404.0585435934273;15044.473443429482;15254;16427.096509691946;20445.079971401286;20897.37307880762;19089.331873384435;19119.90440047801;19494.610107797835;19664.016799160057;20237.190512379486;5751.1373294006025;5793.217915581406;6037.2151620289305;6041.063635136561;6045.304789949146;5326.6005049621235;5948.315943666469;6002.369751176129;6008.399160084;6013.909791353133;5694.4590263924865;5843.8539036524;5949.88100237995;5951.6429014259065;5952.732127054272;5935.584509084366;5949.85125371867;5952.047672372421;5962.850928726773;5988.520918326523;4928.433230178503;5084.542391184774;5150.175971844525;5175.0943584872875;5180.533751962342;24875.62686559703;24956;25064.248072557853;25283.367915802068;25345.74654253452;1900.2968901506392;2215.9778402216093;2330.4523436992295;2338.473843385225;2378.38162077861;15129.319180636898;15575.299111539895;15634.765478517831;15839.366425342972;16263.512094637179;1805.4312891439286;1867.1691097461635;1888.7166924961366;1893.5360836594984;1904.352520143158;114625.42687286594;120363;125284;125919.37040314832;126519;8486.405951583454;10318.690439286833;10889;11184.552617895193;11251.268667536584;13520.526781562598;13522.12106213093;13524.93237533806;13533.729325413633;13552.390142443614;8193.8361232775;8435.493870367798;8467.195616416431;8520.829583408296;8572.785680358042;8470.322374210049;8519.659213631385;8570.78573035679;8598.355123365647;8769.868451973225;5722.685252311079;6070.544709146831;6306.400891915352;6437.388448097423;6537.836554086186;1679.0355284317377;1738.1483073293996;1792.4264235444793;1797.9460616181536;1839.6504664113775;903.6927444668844;905.9547022648841;934.345957829522;960.6493629825063;981.8674478945394;20455.79544204539;21015.949202540116;21416.143354265656;21468.355949321547;21631.59469432507;759.2862709053472;893.1291990309526;949.3734135470556;958.8705524754208;1016.8271393863062;9178.816423671622;9337.579808908615;11606.593769218036;11635.360055197045;11746;559238;566342;578686;599285;599568;64729.35270647328;85885.14114858772;97959;116066.41966790281;121953;983.3952119446488;996.1731762636994;1013.8023085498257;1049.443794788748;1051.106559424483;14402.639934001734;18611.883287002824;19218.270355668057;20107.59784804325;20141.295054673017;56431.43568564262;57248;57900;57993;58479.4152058474;69171;71346.9184890656;72549.73018859512;72955.27044729485;76780;7883.763487095396;7889.64496597643;8040.638171282423;8110.026796784424;8123.025236971601;12876.420561074587;13001.4149363277;13008.349582521025;13387.330633468093;13505;11026.669199924016;11214.439278036229;11280.717982050186;11526.481308341312;11809.350485723367;5009.9248511271635;9588.137067663944;10712.35725856451;10917.781644366909;11418.029467495024;11428.771424571629;11536.673282572612;11626.128040396836;11636.709082273012;11642.24325418879;7682.308592226726;7833.37333013369;8172.468789528662;8202.753917382488;8228.300594449538;11155.49800258974;11376.943466392517;11496.48265828023;11559.133065020325;11632.53469861196 03:30:41 INFO - PROCESS | 1663 | |3;mootools.html;1518.9772153417698;1528.9847101528985;1586.5716256610722;1697.8387053229947;1856.220387437277;8438.156184381558;9018.954905225473;9020.954895225532;9027.684031058914;9030;7873.448858579902;8096.068952070514;8105.1489593592705;8548;8800.95599522003;2348.741638419777;2398.9880050599722;2399.292208798409;2402.8197885158597;2402.9879850600723;2353.564590550745;2387.3673476528734;2399.3042017814814;2402.783749462548;2407.2898494944034;2365.5860224460653;2383.118246248882;2390.9760902390926;2392.222527678503;2395.73646898841;2350.001249468986;2359.7876191142796;2364.9172278970327;2371.5494056129282;2373.8219633527556;2372.110458578033;2377.09670325277;2378.97621023791;2379.9167029153896;2380.214529205358;8784.47293162406;8836.425632333878;8908.599113039863;8915.643374265022;8917.019127895926;5157.948420515784;5330.28041214435;5334;5334.493223143795;5342.599305052097;3386.4412371958597;3518.9296214075575;3543.6810687038032;3552.0409489437966;3620.71034317254;1096.5230124895616;1096.6929259807187;1106.8616422947132;1127.053275248795;1129.091081679248;10380.480975951172;11790.764184716343;11793.410329483491;11805.88194118065;11839.585614503538;4574.428196475441;4587.220172570671;4792.95207047932;4799.904001919942;4815.807367705253;10109.140723038478;10130.544125514369;10139.239557033252;10145.239107066853;10152.289339746147;5348.625596208306;5349.170878513836;5351.3043304370185;5351.705656188869;5353.491418315254;4343.413639158736;4389.31965545341;4841.491643377465;4878.195097808893;4894.755262236874;3939.763614183158;3988.746358307547;4046.635802777764;4054.2364071628936;4083.9387409188294;1277.303869391184;1283.1915892987358;1287;1292.5217669462359;1299.6548572227887;829.3613917283658;851.3231980575333;870.621279743301;912.2838571721167;920.249996253065;5848.181254624356;5958.791442299499;6082;6083.574149809471;6132.325444201134;898.389095415124;900.8108297257518;937.465644582595;956.6556039825797;995.7709726762885;3800.524934383202;3917.8628747993685;3979.900502487461;4048.67610591152;4125.628693417607;10565.9471702641;11032.834507482394;11033.282836615594;11047.337159770439;11066.723331916766;10995.065419439437;10996.670099897015;11001.724956876142;11003.394813285186;11005.119590432747;8233.958830205811;8402;8415.284700800377;8434.746957591282;8451.788705282417;5918.260217472816;5944.6730429826775;6050.364711705208;6119.755209791559;6152.200213972334;9684.46735429558;9921.15670168015;10002.549885255326;10133.03736145065;10324;8684.869726953975;9963.25275604347;10331.638392656221;10365.222608304257;10432.68701938943;6905.205901321211;6916.066331045245;7210.567365958059;7548.3961283098315;7699.730509432367;8263.504189748634;8556.058833528183;8560.357973152162;8565.314774818124;8566.314694824274;7418.332350088518;7567.659455324413;7568.810779730551;7604.733834315773;7683.423743219169;7264.309890560388;7299.124105107421;7302.269773022867;7495.775126746206;7517.060367454068;5989.790357337472;7050.506464547432;7052.612106333996;7057.858842823218;7075.787726368218;4922.409310882717;4981.850544483671;5005;5043.42000669913;5118.360204974379;4984.127777638972;5062.493750624908;5107.361579802525;5159.896802063862;5168.224766285088 03:30:41 INFO - PROCESS | 1663 | |4;prototype.html;242.77664548615274;276.1604721646196;302.3454221610213;303.19199333775475;316.88750493574764;4884.900897298106;5310.336207974008;5319.723266416061;5582.469665381793;5643.097104463276;4591.816327346911;4698.754829970061;5245.79016839327;5377.843763590828;5505.752241149148;3545.8936231912953;4215.262329092397;4242.957570424287;4266.424032755584;4270.252705776492;3620;4213.705040647156;4234.682398820086;4237.343211802176;4242.9575704243025;3935.940960885589;4178.352355384905;4182.91634167318;4203.684723645723;4266.189424009443;3422.606400263952;4185.414042034117;4192.727472714264;4210.305299625558;4213.662906967435;2965.3624470738896;3273.2635157089703;3302.256992176765;3565.484669015658;3594.4069228577255;4791.856244312677;5036.748162591893;5266.60500462463;5381.901058587154;5441.972790136064;3939.3893946438347;4736.857894263143;4745.335653008581;4746.288056791509;4794.801299675081;4774.379330686988;4928.654994150411;5724.139654612268;5800.8259752207505;5857.76568937242;3745.7752534847723;3893.474380958591;3906.5312162540395;3938.586448422903;3940.960590394088;5197.714125723083;5360.892782144335;5987.431194036603;6134.263888333428;6212.899486338994;3990.700697447703;3994.7802870842384;3997.420374045747;4004.2391945530258;4004.9599504004586;3498.737594680409;3587.408077667156;3934.7048971327263;3947;4080.6123418275215;4289.806958686867;4419.513853476115;4439.733615983051;4580.946382332082;4769.354572672422;4706.247000479975;4813.735244561512;5432.701201433959;5831.271091113611;5853.151293062482;1181.787278289899;1294.3528235882059;1362.1758835904334;1380.8342998840203;1404.789281607767;834.2200042959852;863.7926897544544;882.3999680217386;884.8982367027875;885.6457417033238;4360.869173924787;4801.663883528189;5415.593830462731;5427.185922111715;5461.208124821878;5086.643934924594;5908.320543137508;5929.199558059607;5938.079597662369;5974.2830860297045;5079.796808127633;5371.731413429313;5393.496430480514;5445.101558242845;5448.645838020516;2570.6658134442405;2868.827870327745;2882.8900873163984;3150.7479401647815;3167.382360439738;4932.087563800708;5633.408492108351;5896.292444906639;5946.732397042057;6239.06414037898;5149.7813866333545;5789.102689083199;5895.764169433261;6247.344028876993;6264.812055638338;5297.576193904479;5515.696636685021;6145.5698101133385;6307.810765677037;6401.359864013654;5015.370004748398;5841.824745257649;6059.42454961722;6091.715606647507;6130.478909292582;5063.772130254221;5230.450802665665;5962.1951036611235;6006.279246490449;6045.365236650265;5480.971485957738;5591.245181900554;6060.575759696779;6152.569320147547;6402.871942561216;3376.7805092668896;3977.3636218204947;4035.93946090803;4041.312976794011;4052.9594704052583;4713.151632706145;5285.286486324297;5356.803710478685;5772;6115.5628427320435;4879.853604391874;4910.729909854992;5430.294061771944;5946.680794490238;6035.668038257938;4868.707877527359;5558.860433611019;5652.802151924663;5882.470577648032;5896.380880007709;4847.2729090636685;5481.780728770805;5666.631668941505;5696.069711898776;5700.489370316786;4738.7867545959825;5113.53978141969;5859.326177489473;5902.730912853757;5916.349201587908;4720.905581888412;5753.741081651252;5774.249347584787;5778.682172480386;5825.9996102008345 03:30:41 INFO - PROCESS | 1663 | |5;yui.html;712.7683502861571;714.4998501049267;750.4221749253076;752.8945947567338;803.4014659078987;13923.677250661196;14296.499622513214;16236.107014114219;16252.51242462725;16367.099809510471;14547.563573092797;14668.046576972516;14704.97065205436;14706.264686765673;14713.411463541446;645.4449173710605;657.3229573539251;757.1482082657011;838.1409055717877;850.6469815026757;849.1975083546051;850.7617866997251;853.036069241759;854.6325080215505;856.6102423397339;698.9965050174767;910.0126362896233;913.0595486648763;915.1214833759599;916.7112359606735;713.9393151582121;717.1931576975902;718.3534818663193;721.6103304215717;881.8985816631106;671.717878491035;677.678102901118;679.813051410861;682.8292926768308;682.9925859357458;15097.094174349464;15097.32062057199;15156.545303640909;15168.696626067416;15231.923840380838;13774.242416667079;13829.452407239967;13861.653458663513;13984.580462586138;14054.929725351309;12368.62894113169;12757.107002509829;12767;12781.936090319488;13231;4440.888977775549;4471.276948754648;4549.090181963587;4562.064776720797;4619.3763841881255;116055;118582;118802.40598797037;118837;126026.99999999908;10526.31578947366;10715.946420267848;10822.567097316176;11217.71955701114;11268.830967535494;21575;21575.02912368947;21609.35171944844;21610.13559457604;21631.78368216329;6225.315215326311;7750;7897.210278972057;7946.6424010919645;8105.230003149692;3345.8828940987437;4111.075008123208;4237.63980061692;4281.293586558245;4345.695801293942;3498.2478767065204;3612.8012959286966;3623.8912832615065;4012.498437695288;4216.641585465209;746.1121265693807;765.1315756616281;776.6078130544153;780.8906753054576;785.4855069929206;622.1942584353274;637.8979363301942;653.1867824558456;655.8294843340766;678.6437120511672;7597.5821329826285;8937.776555586031;9394.95302523483;9397;9764.902350976541;522.4462070205518;612.1735656863199;614.4211155398214;616.608453631947;660.0033948737441;4493.842715504941;4678.625709943196;4685.156671799041;4712.922577667957;4729.929051064237;128706.71293287135;158053;162082;168302;176152;136145;139015;143149;147562;150138;101676;120096;124405;127287.72712272944;129182.70817291707;7616.543007419351;8841.69054083104;9047.502387368759;9116.225120864801;9197.632094716137;67188;67784;68040.6597967007;68353.3164668347;70649;101452;102411;104019;107667;110652;11847.585334513251;12150.635480935585;12151.75696486083;12162.75674486523;12419.130660853654;12554.372281385711;12679.302638354979;12827;13054.477820887058;13242;11916.582919597773;12078.758424831278;12128.09039322072;12400.19398739079;12821;12081.818772718241;12944.546940857024;14205.786913196103;14330.856691432953;14650.560483185522;10486.528106235086;12872.607155649093;14012.089214201043;14452.566423007327;14492.637684057983;10805.351678899291;10897.509612067317;11465.656030319104;11647.242929209575;12028.518859245882;10107.79784404293;10852.457377130953;11689.123315751183;11775.23460975034;11810.409479525817 03:30:41 INFO - PROCESS | 1663 | __end_tp_report 03:30:41 INFO - PROCESS | 1663 | __start_cc_report 03:30:41 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1328 03:30:41 INFO - PROCESS | 1663 | __end_cc_report 03:30:41 INFO - PROCESS | 1663 | __startTimestamp1476786641629__endTimestamp 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | ------- Summary: start ------- 03:30:41 INFO - PROCESS | 1663 | Number of tests: 6 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5769.79 Median:6038.25 stddev:644.20 (10.7%) stddev-sans-first:617.51 03:30:41 INFO - PROCESS | 1663 | Values: 3347.4 3351.7 3361.3 3377.0 3388.9 5647.2 5762.3 5763.8 5794.7 5795.0 5732.6 5787.4 5787.9 5800.7 5806.8 5238.0 5258.6 5270.1 5277.2 5318.1 5209.9 5210.8 5219.3 5342.9 5349.2 5233.6 5272.4 5289.8 5331.5 5350.8 5252.5 5319.3 5339.2 5341.2 5351.8 5224.2 5246.3 5273.9 5275.0 5277.7 5618.2 5651.9 5677.0 5681.8 5702.5 5187.7 6131.0 6170.6 6201.1 6212.0 6197.1 6224.0 6234.3 6248.4 6266.4 5724.6 5733.2 5771.1 5807.3 5871.8 6276.5 6299.6 6307.0 6322.4 6327.0 6159.6 6165.2 6169.0 6169.6 6173.3 5525.4 5968.8 6142.3 6166.9 6183.0 6151.8 6222.7 6239.3 6240.5 6245.4 6165.3 6200.5 6209.3 6228.0 6241.6 4878.7 4923.5 4962.5 4981.2 5001.2 4022.9 4290.5 4365.9 4408.1 4467.1 5845.6 5853.4 5881.1 5886.8 5894.7 6269.3 6281.1 6298.8 6306.7 6315.9 5558.8 5658.2 5668.1 5707.1 5711.4 5419.6 5446.3 5460.1 5466.3 5497.3 6354.4 6357.6 6362.7 6364.4 6372.4 6116.5 6212.9 6256.5 6302.0 6304.5 6307.4 6389.4 6400.4 6413.6 6418.9 6273.1 6274.2 6275.3 6276.5 6285.2 6148.0 6203.5 6237.8 6301.1 6305.2 6038.2 6102.5 6128.1 6161.9 6229.0 5989.6 6157.4 6218.1 6226.3 6232.8 5816.7 5957.9 6034.6 6072.4 6087.8 6064.0 6131.4 6131.9 6136.8 6221.2 6039.7 6043.8 6050.3 6053.7 6058.2 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:75684.59 Median:35593.73 stddev:174328.42 (489.8%) stddev-sans-first:174725.97 03:30:41 INFO - PROCESS | 1663 | Values: 461.1 471.6 526.0 533.1 536.8 30649.9 40285.4 41363.8 41399.0 41547.2 43115.8 43472.8 43505.8 43548.3 43560.0 9761.9 9972.3 9976.2 9980.0 9998.0 8197.9 8948.0 11969.6 12219.5 12246.4 12212.3 12283.0 12310.3 12328.2 12374.9 8802.7 12233.6 12288.5 12312.8 12313.0 8696.9 11814.4 12156.4 12161.3 12373.4 41288.4 41743.6 41747.0 41783.4 41831.0 3333.8 3414.8 3524.4 3700.4 3960.1 25016.5 30547.0 31652.5 31723.7 31981.4 3148.5 3214.2 3238.9 3251.7 3366.3 527045.0 527246.4 527358.4 528142.0 528533.0 33366.0 62786.0 63159.7 63318.4 63358.0 34375.7 35389.5 35798.0 36265.6 36337.9 14947.5 15087.2 15089.8 15096.6 15102.8 11381.3 11571.0 12714.7 12774.1 12794.3 7816.6 7909.0 7943.0 8053.2 8108.6 3232.7 3239.3 3255.6 3288.7 3333.9 895.3 964.9 1042.6 1058.5 1106.9 30328.8 30492.8 30763.7 31307.2 31325.8 1050.8 1053.7 1074.2 1114.2 1125.2 15739.1 15943.4 15968.8 15974.5 16165.5 721794.0 728602.0 729931.0 732665.0 733042.0 58615.4 59369.7 59377.8 59398.0 59514.7 1085.8 1232.2 1272.4 1353.0 1381.7 23959.9 28339.3 28466.4 31562.4 31665.6 44852.9 57729.4 58027.4 58041.4 58091.5 666416.0 674730.0 674936.0 675872.0 677244.0 26533.7 27432.7 27527.0 27945.7 28278.9 39132.4 47532.0 47950.3 48040.8 48621.0 39625.8 39759.4 39965.4 40040.0 41850.6 39476.2 39732.4 39932.8 41251.2 41443.0 36359.6 38579.0 38593.0 38636.0 38719.4 30823.0 34251.5 35136.3 35164.6 35199.5 21403.7 25213.9 25276.9 25341.2 25797.9 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33809.34 Median:12841.43 stddev:96548.32 (751.9%) stddev-sans-first:96786.45 03:30:41 INFO - PROCESS | 1663 | Values: 337.1 369.5 378.6 386.4 404.1 15044.5 15254.0 16427.1 20445.1 20897.4 19089.3 19119.9 19494.6 19664.0 20237.2 5751.1 5793.2 6037.2 6041.1 6045.3 5326.6 5948.3 6002.4 6008.4 6013.9 5694.5 5843.9 5949.9 5951.6 5952.7 5935.6 5949.9 5952.0 5962.9 5988.5 4928.4 5084.5 5150.2 5175.1 5180.5 24875.6 24956.0 25064.2 25283.4 25345.7 1900.3 2216.0 2330.5 2338.5 2378.4 15129.3 15575.3 15634.8 15839.4 16263.5 1805.4 1867.2 1888.7 1893.5 1904.4 114625.4 120363.0 125284.0 125919.4 126519.0 8486.4 10318.7 10889.0 11184.6 11251.3 13520.5 13522.1 13524.9 13533.7 13552.4 8193.8 8435.5 8467.2 8520.8 8572.8 8470.3 8519.7 8570.8 8598.4 8769.9 5722.7 6070.5 6306.4 6437.4 6537.8 1679.0 1738.1 1792.4 1797.9 1839.7 903.7 906.0 934.3 960.6 981.9 20455.8 21015.9 21416.1 21468.4 21631.6 759.3 893.1 949.4 958.9 1016.8 9178.8 9337.6 11606.6 11635.4 11746.0 559238.0 566342.0 578686.0 599285.0 599568.0 64729.4 85885.1 97959.0 116066.4 121953.0 983.4 996.2 1013.8 1049.4 1051.1 14402.6 18611.9 19218.3 20107.6 20141.3 56431.4 57248.0 57900.0 57993.0 58479.4 69171.0 71346.9 72549.7 72955.3 76780.0 7883.8 7889.6 8040.6 8110.0 8123.0 12876.4 13001.4 13008.3 13387.3 13505.0 11026.7 11214.4 11280.7 11526.5 11809.4 5009.9 9588.1 10712.4 10917.8 11418.0 11428.8 11536.7 11626.1 11636.7 11642.2 7682.3 7833.4 8172.5 8202.8 8228.3 11155.5 11376.9 11496.5 11559.1 11632.5 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5751.64 Median:4908.58 stddev:3220.82 (65.6%) stddev-sans-first:3214.14 03:30:41 INFO - PROCESS | 1663 | Values: 1519.0 1529.0 1586.6 1697.8 1856.2 8438.2 9019.0 9021.0 9027.7 9030.0 7873.4 8096.1 8105.1 8548.0 8801.0 2348.7 2399.0 2399.3 2402.8 2403.0 2353.6 2387.4 2399.3 2402.8 2407.3 2365.6 2383.1 2391.0 2392.2 2395.7 2350.0 2359.8 2364.9 2371.5 2373.8 2372.1 2377.1 2379.0 2379.9 2380.2 8784.5 8836.4 8908.6 8915.6 8917.0 5157.9 5330.3 5334.0 5334.5 5342.6 3386.4 3518.9 3543.7 3552.0 3620.7 1096.5 1096.7 1106.9 1127.1 1129.1 10380.5 11790.8 11793.4 11805.9 11839.6 4574.4 4587.2 4793.0 4799.9 4815.8 10109.1 10130.5 10139.2 10145.2 10152.3 5348.6 5349.2 5351.3 5351.7 5353.5 4343.4 4389.3 4841.5 4878.2 4894.8 3939.8 3988.7 4046.6 4054.2 4083.9 1277.3 1283.2 1287.0 1292.5 1299.7 829.4 851.3 870.6 912.3 920.2 5848.2 5958.8 6082.0 6083.6 6132.3 898.4 900.8 937.5 956.7 995.8 3800.5 3917.9 3979.9 4048.7 4125.6 10565.9 11032.8 11033.3 11047.3 11066.7 10995.1 10996.7 11001.7 11003.4 11005.1 8234.0 8402.0 8415.3 8434.7 8451.8 5918.3 5944.7 6050.4 6119.8 6152.2 9684.5 9921.2 10002.5 10133.0 10324.0 8684.9 9963.3 10331.6 10365.2 10432.7 6905.2 6916.1 7210.6 7548.4 7699.7 8263.5 8556.1 8560.4 8565.3 8566.3 7418.3 7567.7 7568.8 7604.7 7683.4 7264.3 7299.1 7302.3 7495.8 7517.1 5989.8 7050.5 7052.6 7057.9 7075.8 4922.4 4981.9 5005.0 5043.4 5118.4 4984.1 5062.5 5107.4 5159.9 5168.2 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4615.93 Median:5071.78 stddev:1442.40 (28.4%) stddev-sans-first:1408.60 03:30:41 INFO - PROCESS | 1663 | Values: 242.8 276.2 302.3 303.2 316.9 4884.9 5310.3 5319.7 5582.5 5643.1 4591.8 4698.8 5245.8 5377.8 5505.8 3545.9 4215.3 4243.0 4266.4 4270.3 3620.0 4213.7 4234.7 4237.3 4243.0 3935.9 4178.4 4182.9 4203.7 4266.2 3422.6 4185.4 4192.7 4210.3 4213.7 2965.4 3273.3 3302.3 3565.5 3594.4 4791.9 5036.7 5266.6 5381.9 5442.0 3939.4 4736.9 4745.3 4746.3 4794.8 4774.4 4928.7 5724.1 5800.8 5857.8 3745.8 3893.5 3906.5 3938.6 3941.0 5197.7 5360.9 5987.4 6134.3 6212.9 3990.7 3994.8 3997.4 4004.2 4005.0 3498.7 3587.4 3934.7 3947.0 4080.6 4289.8 4419.5 4439.7 4580.9 4769.4 4706.2 4813.7 5432.7 5831.3 5853.2 1181.8 1294.4 1362.2 1380.8 1404.8 834.2 863.8 882.4 884.9 885.6 4360.9 4801.7 5415.6 5427.2 5461.2 5086.6 5908.3 5929.2 5938.1 5974.3 5079.8 5371.7 5393.5 5445.1 5448.6 2570.7 2868.8 2882.9 3150.7 3167.4 4932.1 5633.4 5896.3 5946.7 6239.1 5149.8 5789.1 5895.8 6247.3 6264.8 5297.6 5515.7 6145.6 6307.8 6401.4 5015.4 5841.8 6059.4 6091.7 6130.5 5063.8 5230.5 5962.2 6006.3 6045.4 5481.0 5591.2 6060.6 6152.6 6402.9 3376.8 3977.4 4035.9 4041.3 4053.0 4713.2 5285.3 5356.8 5772.0 6115.6 4879.9 4910.7 5430.3 5946.7 6035.7 4868.7 5558.9 5652.8 5882.5 5896.4 4847.3 5481.8 5666.6 5696.1 5700.5 4738.8 5113.5 5859.3 5902.7 5916.3 4720.9 5753.7 5774.2 5778.7 5826.0 03:30:41 INFO - PROCESS | 1663 | 03:30:41 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:26556.04 Median:21575.01 stddev:43681.82 (202.5%) stddev-sans-first:43761.26 03:30:41 INFO - PROCESS | 1663 | Values: 712.8 714.5 750.4 752.9 803.4 13923.7 14296.5 16236.1 16252.5 16367.1 14547.6 14668.0 14705.0 14706.3 14713.4 645.4 657.3 757.1 838.1 850.6 849.2 850.8 853.0 854.6 856.6 699.0 910.0 913.1 915.1 916.7 713.9 717.2 718.4 721.6 881.9 671.7 677.7 679.8 682.8 683.0 15097.1 15097.3 15156.5 15168.7 15231.9 13774.2 13829.5 13861.7 13984.6 14054.9 12368.6 12757.1 12767.0 12781.9 13231.0 4440.9 4471.3 4549.1 4562.1 4619.4 116055.0 118582.0 118802.4 118837.0 126027.0 10526.3 10715.9 10822.6 11217.7 11268.8 21575.0 21575.0 21609.4 21610.1 21631.8 6225.3 7750.0 7897.2 7946.6 8105.2 3345.9 4111.1 4237.6 4281.3 4345.7 3498.2 3612.8 3623.9 4012.5 4216.6 746.1 765.1 776.6 780.9 785.5 622.2 637.9 653.2 655.8 678.6 7597.6 8937.8 9395.0 9397.0 9764.9 522.4 612.2 614.4 616.6 660.0 4493.8 4678.6 4685.2 4712.9 4729.9 128706.7 158053.0 162082.0 168302.0 176152.0 136145.0 139015.0 143149.0 147562.0 150138.0 101676.0 120096.0 124405.0 127287.7 129182.7 7616.5 8841.7 9047.5 9116.2 9197.6 67188.0 67784.0 68040.7 68353.3 70649.0 101452.0 102411.0 104019.0 107667.0 110652.0 11847.6 12150.6 12151.8 12162.8 12419.1 12554.4 12679.3 12827.0 13054.5 13242.0 11916.6 12078.8 12128.1 12400.2 12821.0 12081.8 12944.5 14205.8 14330.9 14650.6 10486.5 12872.6 14012.1 14452.6 14492.6 10805.4 10897.5 11465.7 11647.2 12028.5 10107.8 10852.5 11689.1 11775.2 11810.4 03:30:41 INFO - PROCESS | 1663 | -------- Summary: end -------- 03:30:41 INFO - PROCESS | 1663 | 03:30:42 INFO - TEST-INFO | 1663: exit 0 03:30:42 INFO - TEST-OK | dromaeo_css | took 1116910ms 03:30:42 INFO - TEST-START | kraken 03:30:42 INFO - operating with platform_type : mac_ 03:30:42 INFO - Initialising browser for kraken test... 03:30:42 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpWTvbXh/profile http://localhost:49270/getInfo.html) 03:30:44 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 03:30:44 INFO - PROCESS | 1670 | colorDepth:24 03:30:44 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 03:30:44 INFO - PROCESS | 1670 | __metrics 03:30:44 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:30:44 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:30:45 INFO - TEST-INFO | 1670: exit 0 03:30:45 INFO - Browser initialized. 03:30:45 INFO - Running cycle 1/1 for kraken test... 03:30:45 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpWTvbXh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:57 INFO - PROCESS | 1672 | RSS: Main: 219590656 03:30:57 INFO - PROCESS | 1672 | 03:30:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:00 INFO - PROCESS | 1672 | RSS: Main: 269197312 03:31:00 INFO - PROCESS | 1672 | 03:31:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 03:31:03 INFO - PROCESS | 1672 | RSS: Main: 279695360 03:31:03 INFO - PROCESS | 1672 | 03:31:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 03:31:07 INFO - PROCESS | 1672 | RSS: Main: 379031552 03:31:07 INFO - PROCESS | 1672 | 03:31:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 03:31:10 INFO - PROCESS | 1672 | RSS: Main: 279867392 03:31:10 INFO - PROCESS | 1672 | 03:31:12 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:12 INFO - PROCESS | 1672 | RSS: Main: 280477696 03:31:12 INFO - PROCESS | 1672 | 03:31:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:16 INFO - PROCESS | 1672 | RSS: Main: 317890560 03:31:16 INFO - PROCESS | 1672 | 03:31:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:19 INFO - PROCESS | 1672 | RSS: Main: 318238720 03:31:19 INFO - PROCESS | 1672 | 03:31:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 03:31:23 INFO - PROCESS | 1672 | RSS: Main: 317804544 03:31:23 INFO - PROCESS | 1672 | 03:31:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:25 INFO - PROCESS | 1672 | RSS: Main: 289533952 03:31:25 INFO - PROCESS | 1672 | 03:31:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:28 INFO - PROCESS | 1672 | RSS: Main: 295985152 03:31:28 INFO - PROCESS | 1672 | 03:31:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:30 INFO - PROCESS | 1672 | RSS: Main: 301756416 03:31:30 INFO - PROCESS | 1672 | 03:31:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:34 INFO - PROCESS | 1672 | RSS: Main: 311341056 03:31:34 INFO - PROCESS | 1672 | 03:31:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:38 INFO - PROCESS | 1672 | RSS: Main: 310714368 03:31:38 INFO - PROCESS | 1672 | 03:31:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 03:31:39 INFO - PROCESS | 1672 | RSS: Main: 354791424 03:31:39 INFO - PROCESS | 1672 | 03:31:39 INFO - PROCESS | 1672 | __start_tp_report 03:31:39 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 03:31:39 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 03:31:39 INFO - PROCESS | 1672 | |i|pagename|runs| 03:31:39 INFO - PROCESS | 1672 | |0;ai-astar;115;115;114;114;114;115;115;115;114;113 03:31:39 INFO - PROCESS | 1672 | |1;audio-beat-detection;144;111;110;144;120;109;108;108;141;108 03:31:39 INFO - PROCESS | 1672 | |2;audio-dft;183;183;181;185;185;183;183;185;184;186 03:31:39 INFO - PROCESS | 1672 | |3;audio-fft;83;77;82;114;60;59;59;60;83;58 03:31:39 INFO - PROCESS | 1672 | |4;audio-oscillator;83;71;94;71;69;69;92;68;69;90 03:31:39 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;88;86;88;86;89;84;88;85;88;85 03:31:39 INFO - PROCESS | 1672 | |6;imaging-darkroom;101;97;100;147;97;96;98;98;119;161 03:31:39 INFO - PROCESS | 1672 | |7;imaging-desaturate;93;95;93;95;92;126;132;92;93;95 03:31:39 INFO - PROCESS | 1672 | |8;json-parse-financial;56;53;52;53;57;59;56;58;57;57 03:31:39 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;63;71;72;78;75;71;68;69;70;69 03:31:39 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;84;81;85;83;86;86;84;83;84;84 03:31:39 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;144;150;122;144;143;145;145;156;200;137 03:31:39 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;164;165;164;225;187;165;163;165;163;164 03:31:39 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;66;65;67;66;64;67;66;66;66;66 03:31:39 INFO - PROCESS | 1672 | __end_tp_report 03:31:39 INFO - PROCESS | 1672 | __start_cc_report 03:31:39 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1916 03:31:39 INFO - PROCESS | 1672 | __end_cc_report 03:31:39 INFO - PROCESS | 1672 | __startTimestamp1476786699986__endTimestamp 03:31:39 INFO - PROCESS | 1672 | 03:31:39 INFO - PROCESS | 1672 | ------- Summary: start ------- 03:31:39 INFO - PROCESS | 1672 | Number of tests: 14 03:31:39 INFO - PROCESS | 1672 | 03:31:39 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:31:39 INFO - PROCESS | 1672 | Values: 115.0 115.0 114.0 114.0 114.0 115.0 115.0 115.0 114.0 113.0 03:31:39 INFO - PROCESS | 1672 | 03:31:39 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:115.50 stddev:16.08 (13.9%) stddev-sans-first:14.59 03:31:39 INFO - PROCESS | 1672 | Values: 144.0 111.0 110.0 144.0 120.0 109.0 108.0 108.0 141.0 108.0 03:31:39 INFO - PROCESS | 1672 | 03:31:39 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.48 (0.8%) stddev-sans-first:1.54 03:31:39 INFO - PROCESS | 1672 | Values: 183.0 183.0 181.0 185.0 185.0 183.0 183.0 185.0 184.0 186.0 03:31:39 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:73.50 Median:68.50 stddev:18.04 (26.3%) stddev-sans-first:18.81 03:31:40 INFO - PROCESS | 1672 | Values: 83.0 77.0 82.0 114.0 60.0 59.0 59.0 60.0 83.0 58.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.00 stddev:10.85 (14.1%) stddev-sans-first:11.34 03:31:40 INFO - PROCESS | 1672 | Values: 83.0 71.0 94.0 71.0 69.0 69.0 92.0 68.0 69.0 90.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.74 03:31:40 INFO - PROCESS | 1672 | Values: 88.0 86.0 88.0 86.0 89.0 84.0 88.0 85.0 88.0 85.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:96.50 stddev:23.65 (24.5%) stddev-sans-first:24.78 03:31:40 INFO - PROCESS | 1672 | Values: 101.0 97.0 100.0 147.0 97.0 96.0 98.0 98.0 119.0 161.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:93.00 stddev:15.08 (16.2%) stddev-sans-first:15.74 03:31:40 INFO - PROCESS | 1672 | Values: 93.0 95.0 93.0 95.0 92.0 126.0 132.0 92.0 93.0 95.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:2.35 (4.1%) stddev-sans-first:2.49 03:31:40 INFO - PROCESS | 1672 | Values: 56.0 53.0 52.0 53.0 57.0 59.0 56.0 58.0 57.0 57.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:4.03 (5.7%) stddev-sans-first:3.21 03:31:40 INFO - PROCESS | 1672 | Values: 63.0 71.0 72.0 78.0 75.0 71.0 68.0 69.0 70.0 69.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 03:31:40 INFO - PROCESS | 1672 | Values: 84.0 81.0 85.0 83.0 86.0 86.0 84.0 83.0 84.0 84.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:145.00 stddev:20.11 (13.9%) stddev-sans-first:21.26 03:31:40 INFO - PROCESS | 1672 | Values: 144.0 150.0 122.0 144.0 143.0 145.0 145.0 156.0 200.0 137.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:165.00 stddev:19.81 (12.0%) stddev-sans-first:20.77 03:31:40 INFO - PROCESS | 1672 | Values: 164.0 165.0 164.0 225.0 187.0 165.0 163.0 165.0 163.0 164.0 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 03:31:40 INFO - PROCESS | 1672 | Values: 66.0 65.0 67.0 66.0 64.0 67.0 66.0 66.0 66.0 66.0 03:31:40 INFO - PROCESS | 1672 | -------- Summary: end -------- 03:31:40 INFO - PROCESS | 1672 | 03:31:40 INFO - TEST-INFO | 1672: exit 0 03:31:40 INFO - TEST-OK | kraken | took 58622ms 03:31:40 INFO - SUITE-END | took 1175s 03:31:41 INFO - Completed test suite (00:19:35) 03:31:41 INFO - javascript benchmark 03:31:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.3807345641053, 3351.731861451083, 3361.2605226850083, 3376.9999999999986, 3388.9491657625126, 5647.209390685307, 5762.250907382045, 5763.769449222036, 5794.652320860751, 5795.043817770068, 5732.570057245713, 5787.421257874221, 5787.913181302284, 5800.709964501779, 5806.767729290823, 5237.973810130953, 5258.6318957672975, 5270.130428479296, 5277.182036784286, 5318.069337865877, 5209.947900520984, 5210.7655155517905, 5219.321488206547, 5342.893142137155, 5349.170878513836, 5233.555147812441, 5272.393674727398, 5289.788408463657, 5331.546818520431, 5350.759215835277, 5252.52727254547, 5319.281896943901, 5339.225812257201, 5341.1988201769655, 5351.759170837322, 5224.164133738584, 5246.344206974129, 5273.868153296198, 5274.97362513185, 5277.70972596507, 5618.241537392481, 5651.886962260773, 5677.0, 5681.772729090872, 5702.486776190163, 5187.662801917901, 6130.979101202072, 6170.598911070766, 6201.069839524062, 6211.968940155315, 6197.1324014637985, 6224.0, 6234.3453937336835, 6248.3751624837605, 6266.404691554295, 5724.627899186623, 5733.226014488074, 5771.105478650732, 5807.332156802022, 5871.765129394819, 6276.497880169575, 6299.559030867887, 6306.9684651576445, 6322.36776322364, 6327.0, 6159.599626024294, 6165.229346331708, 6168.9691551542855, 6169.56813023093, 6173.290071641729, 5525.392206857243, 5968.820935371946, 6142.314611233313, 6166.907496387557, 6183.0, 6151.815445536641, 6222.657753823583, 6239.344868788802, 6240.5319601030105, 6245.375462453719, 6165.32181460039, 6200.534959878028, 6209.348018458088, 6228.03465462854, 6241.563090583706, 4878.707277563358, 4923.507649235119, 4962.503749625009, 4981.153203955337, 5001.24981252815, 4022.8591999279884, 4290.4636920384955, 4365.908522869283, 4408.074304396113, 4467.128909862546, 5845.620034697731, 5853.443922827325, 5881.05903055509, 5886.764529418861, 5894.67579283135, 6269.279032911182, 6281.120643109968, 6298.8425289367215, 6306.653134077578, 6315.905261421082, 5558.833235002957, 5658.179563963202, 5668.093105103164, 5707.1153971134545, 5711.371749107595, 5419.6477228980775, 5446.319210098738, 5460.099083651153, 5466.34403871538, 5497.285352904097, 6354.396332348512, 6357.586756860789, 6362.745490180341, 6364.395382438661, 6372.426481616677, 6116.457510225689, 6212.875742485216, 6256.499480041677, 6302.023186406114, 6304.495640348853, 6307.369263073656, 6389.361063893573, 6400.423961843457, 6413.551051426355, 6418.903716444163, 6273.121762953281, 6274.247090349188, 6275.309715931153, 6276.497880169484, 6285.245770507386, 6147.9855823788575, 6203.503719702323, 6237.781677641261, 6301.117843501822, 6305.211848518935, 6038.245219347582, 6102.4507794298725, 6128.142060111499, 6161.907571386522, 6229.0, 5989.610675306091, 6157.3773763783165, 6218.06728990655, 6226.25284965807, 6232.75068997235, 5816.738246778989, 5957.851053723692, 6034.607750496204, 6072.423119803611, 6087.786927457518, 6063.969680151571, 6131.407250743203, 6131.866048757656, 6136.846578835565, 6221.160143380585, 6039.728212230372, 6043.848903777265, 6050.276099914223, 6053.697315134137, 6058.212432383762], "value": 5727.704686265562, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.1215634216818, 471.5802935387505, 525.9874741123339, 533.1420001295486, 536.7879687523429, 30649.927252546164, 40285.39571906424, 41363.793181034125, 41398.96502587433, 41547.16905661885, 43115.78442107793, 43472.78263608678, 43505.7824710876, 43548.3467747984, 43560.0, 9761.853572196405, 9972.252081093911, 9976.201903847676, 9980.0, 9998.0, 8197.918020819776, 8948.0, 11969.640910772647, 12219.511219551207, 12246.387680615979, 12212.267263964146, 12282.955948744322, 12310.322932238769, 12328.19866708661, 12374.876251237507, 8802.735917922408, 12233.63299101024, 12288.508459661603, 12312.81530777039, 12313.0, 8696.869546956801, 11814.350210738407, 12156.392180391034, 12161.331126788024, 12373.381330933418, 41288.38067428991, 41743.58256417427, 41747.0, 41783.37324940128, 41831.0, 3333.8166400848186, 3414.7951122932704, 3524.400851855191, 3700.3524383232825, 3960.0891794887048, 25016.4996700065, 30547.0, 31652.525212121836, 31723.682763172535, 31981.360372792646, 3148.511980643004, 3214.164317277501, 3238.87044518219, 3251.658575849549, 3366.3267346530547, 527045.0, 527246.3637681826, 527358.3632081853, 528142.0, 528533.0, 33366.0, 62786.0, 63159.73680526364, 63318.36681633125, 63358.0, 34375.65624343775, 35389.46915796265, 35798.0, 36265.63734362675, 36337.90986270416, 14947.476838310607, 15087.170205638577, 15089.849101509064, 15096.622584435478, 15102.773458398133, 11381.260218085798, 11571.0, 12714.682132946751, 12774.105812593216, 12794.296313702836, 7816.570088645065, 7909.0113735783025, 7942.960285198537, 8053.234942680436, 8108.635111420001, 3232.7090561849077, 3239.3197428539797, 3255.5604993326074, 3288.7204587609845, 3333.949990750141, 895.2927187521915, 964.8890377606525, 1042.5725452564411, 1058.4972138234432, 1106.8837772033821, 30328.84835575808, 30492.847535762623, 30763.69236307653, 31307.217319567193, 31325.843370783456, 1050.8003479338902, 1053.657561292583, 1074.2050882347007, 1114.2367478277406, 1125.1954852280658, 15739.13434761099, 15943.441979530893, 15968.840311596967, 15974.520764377086, 16165.515034548982, 721794.0, 728602.0, 729931.0, 732665.0, 733042.0, 58615.41384586185, 59369.70315148397, 59377.81244375175, 59398.0, 59514.70242648759, 1085.8273065089684, 1232.2298563397876, 1272.401971073594, 1353.032581704106, 1381.730562540315, 23959.880200598884, 28339.319649378278, 28466.430671386872, 31562.36875262528, 31665.575049123305, 44852.87867803331, 57729.422705774086, 58027.4197258022, 58041.419585803604, 58091.547711307554, 666416.0, 674730.0, 674936.0, 675872.0, 677244.0, 26533.7346626539, 27432.725672743018, 27527.0, 27945.72054279431, 28278.86884524596, 39132.413013804246, 47532.0, 47950.28074578814, 48040.75979620079, 48621.0, 39625.80187099046, 39759.403608946464, 39965.40051899166, 40040.0, 41850.58149418467, 39476.2104757909, 39732.40401393924, 39932.80033599814, 41251.1749765009, 41443.0, 36359.636403635624, 38579.0, 38593.0, 38636.0, 38719.419208712454, 30823.0, 34251.4862277071, 35136.29727405387, 35164.64835351614, 35199.47200792041, 21403.67894481553, 25213.87393063023, 25276.862541185325, 25341.239762807145, 25797.871010644827], "value": 19420.81835941071, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.10666733157115, 369.4790345612687, 378.6005763919065, 386.4107236464391, 404.0585435934273, 15044.473443429482, 15254.0, 16427.096509691946, 20445.079971401286, 20897.37307880762, 19089.331873384435, 19119.90440047801, 19494.610107797835, 19664.016799160057, 20237.190512379486, 5751.1373294006025, 5793.217915581406, 6037.2151620289305, 6041.063635136561, 6045.304789949146, 5326.6005049621235, 5948.315943666469, 6002.369751176129, 6008.399160084, 6013.909791353133, 5694.4590263924865, 5843.8539036524, 5949.88100237995, 5951.6429014259065, 5952.732127054272, 5935.584509084366, 5949.85125371867, 5952.047672372421, 5962.850928726773, 5988.520918326523, 4928.433230178503, 5084.542391184774, 5150.175971844525, 5175.0943584872875, 5180.533751962342, 24875.62686559703, 24956.0, 25064.248072557853, 25283.367915802068, 25345.74654253452, 1900.2968901506392, 2215.9778402216093, 2330.4523436992295, 2338.473843385225, 2378.38162077861, 15129.319180636898, 15575.299111539895, 15634.765478517831, 15839.366425342972, 16263.512094637179, 1805.4312891439286, 1867.1691097461635, 1888.7166924961366, 1893.5360836594984, 1904.352520143158, 114625.42687286594, 120363.0, 125284.0, 125919.37040314832, 126519.0, 8486.405951583454, 10318.690439286833, 10889.0, 11184.552617895193, 11251.268667536584, 13520.526781562598, 13522.12106213093, 13524.93237533806, 13533.729325413633, 13552.390142443614, 8193.8361232775, 8435.493870367798, 8467.195616416431, 8520.829583408296, 8572.785680358042, 8470.322374210049, 8519.659213631385, 8570.78573035679, 8598.355123365647, 8769.868451973225, 5722.685252311079, 6070.544709146831, 6306.400891915352, 6437.388448097423, 6537.836554086186, 1679.0355284317377, 1738.1483073293996, 1792.4264235444793, 1797.9460616181536, 1839.6504664113775, 903.6927444668844, 905.9547022648841, 934.345957829522, 960.6493629825063, 981.8674478945394, 20455.79544204539, 21015.949202540116, 21416.143354265656, 21468.355949321547, 21631.59469432507, 759.2862709053472, 893.1291990309526, 949.3734135470556, 958.8705524754208, 1016.8271393863062, 9178.816423671622, 9337.579808908615, 11606.593769218036, 11635.360055197045, 11746.0, 559238.0, 566342.0, 578686.0, 599285.0, 599568.0, 64729.35270647328, 85885.14114858772, 97959.0, 116066.41966790281, 121953.0, 983.3952119446488, 996.1731762636994, 1013.8023085498257, 1049.443794788748, 1051.106559424483, 14402.639934001734, 18611.883287002824, 19218.270355668057, 20107.59784804325, 20141.295054673017, 56431.43568564262, 57248.0, 57900.0, 57993.0, 58479.4152058474, 69171.0, 71346.9184890656, 72549.73018859512, 72955.27044729485, 76780.0, 7883.763487095396, 7889.64496597643, 8040.638171282423, 8110.026796784424, 8123.025236971601, 12876.420561074587, 13001.4149363277, 13008.349582521025, 13387.330633468093, 13505.0, 11026.669199924016, 11214.439278036229, 11280.717982050186, 11526.481308341312, 11809.350485723367, 5009.9248511271635, 9588.137067663944, 10712.35725856451, 10917.781644366909, 11418.029467495024, 11428.771424571629, 11536.673282572612, 11626.128040396836, 11636.709082273012, 11642.24325418879, 7682.308592226726, 7833.37333013369, 8172.468789528662, 8202.753917382488, 8228.300594449538, 11155.49800258974, 11376.943466392517, 11496.48265828023, 11559.133065020325, 11632.53469861196], "value": 9552.291820335884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.9772153417698, 1528.9847101528985, 1586.5716256610722, 1697.8387053229947, 1856.220387437277, 8438.156184381558, 9018.954905225473, 9020.954895225532, 9027.684031058914, 9030.0, 7873.448858579902, 8096.068952070514, 8105.1489593592705, 8548.0, 8800.95599522003, 2348.741638419777, 2398.9880050599722, 2399.292208798409, 2402.8197885158597, 2402.9879850600723, 2353.564590550745, 2387.3673476528734, 2399.3042017814814, 2402.783749462548, 2407.2898494944034, 2365.5860224460653, 2383.118246248882, 2390.9760902390926, 2392.222527678503, 2395.73646898841, 2350.001249468986, 2359.7876191142796, 2364.9172278970327, 2371.5494056129282, 2373.8219633527556, 2372.110458578033, 2377.09670325277, 2378.97621023791, 2379.9167029153896, 2380.214529205358, 8784.47293162406, 8836.425632333878, 8908.599113039863, 8915.643374265022, 8917.019127895926, 5157.948420515784, 5330.28041214435, 5334.0, 5334.493223143795, 5342.599305052097, 3386.4412371958597, 3518.9296214075575, 3543.6810687038032, 3552.0409489437966, 3620.71034317254, 1096.5230124895616, 1096.6929259807187, 1106.8616422947132, 1127.053275248795, 1129.091081679248, 10380.480975951172, 11790.764184716343, 11793.410329483491, 11805.88194118065, 11839.585614503538, 4574.428196475441, 4587.220172570671, 4792.95207047932, 4799.904001919942, 4815.807367705253, 10109.140723038478, 10130.544125514369, 10139.239557033252, 10145.239107066853, 10152.289339746147, 5348.625596208306, 5349.170878513836, 5351.3043304370185, 5351.705656188869, 5353.491418315254, 4343.413639158736, 4389.31965545341, 4841.491643377465, 4878.195097808893, 4894.755262236874, 3939.763614183158, 3988.746358307547, 4046.635802777764, 4054.2364071628936, 4083.9387409188294, 1277.303869391184, 1283.1915892987358, 1287.0, 1292.5217669462359, 1299.6548572227887, 829.3613917283658, 851.3231980575333, 870.621279743301, 912.2838571721167, 920.249996253065, 5848.181254624356, 5958.791442299499, 6082.0, 6083.574149809471, 6132.325444201134, 898.389095415124, 900.8108297257518, 937.465644582595, 956.6556039825797, 995.7709726762885, 3800.524934383202, 3917.8628747993685, 3979.900502487461, 4048.67610591152, 4125.628693417607, 10565.9471702641, 11032.834507482394, 11033.282836615594, 11047.337159770439, 11066.723331916766, 10995.065419439437, 10996.670099897015, 11001.724956876142, 11003.394813285186, 11005.119590432747, 8233.958830205811, 8402.0, 8415.284700800377, 8434.746957591282, 8451.788705282417, 5918.260217472816, 5944.6730429826775, 6050.364711705208, 6119.755209791559, 6152.200213972334, 9684.46735429558, 9921.15670168015, 10002.549885255326, 10133.03736145065, 10324.0, 8684.869726953975, 9963.25275604347, 10331.638392656221, 10365.222608304257, 10432.68701938943, 6905.205901321211, 6916.066331045245, 7210.567365958059, 7548.3961283098315, 7699.730509432367, 8263.504189748634, 8556.058833528183, 8560.357973152162, 8565.314774818124, 8566.314694824274, 7418.332350088518, 7567.659455324413, 7568.810779730551, 7604.733834315773, 7683.423743219169, 7264.309890560388, 7299.124105107421, 7302.269773022867, 7495.775126746206, 7517.060367454068, 5989.790357337472, 7050.506464547432, 7052.612106333996, 7057.858842823218, 7075.787726368218, 4922.409310882717, 4981.850544483671, 5005.0, 5043.42000669913, 5118.360204974379, 4984.127777638972, 5062.493750624908, 5107.361579802525, 5159.896802063862, 5168.224766285088], "value": 4624.869299335185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [242.77664548615274, 276.1604721646196, 302.3454221610213, 303.19199333775475, 316.88750493574764, 4884.900897298106, 5310.336207974008, 5319.723266416061, 5582.469665381793, 5643.097104463276, 4591.816327346911, 4698.754829970061, 5245.79016839327, 5377.843763590828, 5505.752241149148, 3545.8936231912953, 4215.262329092397, 4242.957570424287, 4266.424032755584, 4270.252705776492, 3620.0, 4213.705040647156, 4234.682398820086, 4237.343211802176, 4242.9575704243025, 3935.940960885589, 4178.352355384905, 4182.91634167318, 4203.684723645723, 4266.189424009443, 3422.606400263952, 4185.414042034117, 4192.727472714264, 4210.305299625558, 4213.662906967435, 2965.3624470738896, 3273.2635157089703, 3302.256992176765, 3565.484669015658, 3594.4069228577255, 4791.856244312677, 5036.748162591893, 5266.60500462463, 5381.901058587154, 5441.972790136064, 3939.3893946438347, 4736.857894263143, 4745.335653008581, 4746.288056791509, 4794.801299675081, 4774.379330686988, 4928.654994150411, 5724.139654612268, 5800.8259752207505, 5857.76568937242, 3745.7752534847723, 3893.474380958591, 3906.5312162540395, 3938.586448422903, 3940.960590394088, 5197.714125723083, 5360.892782144335, 5987.431194036603, 6134.263888333428, 6212.899486338994, 3990.700697447703, 3994.7802870842384, 3997.420374045747, 4004.2391945530258, 4004.9599504004586, 3498.737594680409, 3587.408077667156, 3934.7048971327263, 3947.0, 4080.6123418275215, 4289.806958686867, 4419.513853476115, 4439.733615983051, 4580.946382332082, 4769.354572672422, 4706.247000479975, 4813.735244561512, 5432.701201433959, 5831.271091113611, 5853.151293062482, 1181.787278289899, 1294.3528235882059, 1362.1758835904334, 1380.8342998840203, 1404.789281607767, 834.2200042959852, 863.7926897544544, 882.3999680217386, 884.8982367027875, 885.6457417033238, 4360.869173924787, 4801.663883528189, 5415.593830462731, 5427.185922111715, 5461.208124821878, 5086.643934924594, 5908.320543137508, 5929.199558059607, 5938.079597662369, 5974.2830860297045, 5079.796808127633, 5371.731413429313, 5393.496430480514, 5445.101558242845, 5448.645838020516, 2570.6658134442405, 2868.827870327745, 2882.8900873163984, 3150.7479401647815, 3167.382360439738, 4932.087563800708, 5633.408492108351, 5896.292444906639, 5946.732397042057, 6239.06414037898, 5149.7813866333545, 5789.102689083199, 5895.764169433261, 6247.344028876993, 6264.812055638338, 5297.576193904479, 5515.696636685021, 6145.5698101133385, 6307.810765677037, 6401.359864013654, 5015.370004748398, 5841.824745257649, 6059.42454961722, 6091.715606647507, 6130.478909292582, 5063.772130254221, 5230.450802665665, 5962.1951036611235, 6006.279246490449, 6045.365236650265, 5480.971485957738, 5591.245181900554, 6060.575759696779, 6152.569320147547, 6402.871942561216, 3376.7805092668896, 3977.3636218204947, 4035.93946090803, 4041.312976794011, 4052.9594704052583, 4713.151632706145, 5285.286486324297, 5356.803710478685, 5772.0, 6115.5628427320435, 4879.853604391874, 4910.729909854992, 5430.294061771944, 5946.680794490238, 6035.668038257938, 4868.707877527359, 5558.860433611019, 5652.802151924663, 5882.470577648032, 5896.380880007709, 4847.2729090636685, 5481.780728770805, 5666.631668941505, 5696.069711898776, 5700.489370316786, 4738.7867545959825, 5113.53978141969, 5859.326177489473, 5902.730912853757, 5916.349201587908, 4720.905581888412, 5753.741081651252, 5774.249347584787, 5778.682172480386, 5825.9996102008345], "value": 4149.311150715092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.7683502861571, 714.4998501049267, 750.4221749253076, 752.8945947567338, 803.4014659078987, 13923.677250661196, 14296.499622513214, 16236.107014114219, 16252.51242462725, 16367.099809510471, 14547.563573092797, 14668.046576972516, 14704.97065205436, 14706.264686765673, 14713.411463541446, 645.4449173710605, 657.3229573539251, 757.1482082657011, 838.1409055717877, 850.6469815026757, 849.1975083546051, 850.7617866997251, 853.036069241759, 854.6325080215505, 856.6102423397339, 698.9965050174767, 910.0126362896233, 913.0595486648763, 915.1214833759599, 916.7112359606735, 713.9393151582121, 717.1931576975902, 718.3534818663193, 721.6103304215717, 881.8985816631106, 671.717878491035, 677.678102901118, 679.813051410861, 682.8292926768308, 682.9925859357458, 15097.094174349464, 15097.32062057199, 15156.545303640909, 15168.696626067416, 15231.923840380838, 13774.242416667079, 13829.452407239967, 13861.653458663513, 13984.580462586138, 14054.929725351309, 12368.62894113169, 12757.107002509829, 12767.0, 12781.936090319488, 13231.0, 4440.888977775549, 4471.276948754648, 4549.090181963587, 4562.064776720797, 4619.3763841881255, 116055.0, 118582.0, 118802.40598797037, 118837.0, 126026.99999999908, 10526.31578947366, 10715.946420267848, 10822.567097316176, 11217.71955701114, 11268.830967535494, 21575.0, 21575.02912368947, 21609.35171944844, 21610.13559457604, 21631.78368216329, 6225.315215326311, 7750.0, 7897.210278972057, 7946.6424010919645, 8105.230003149692, 3345.8828940987437, 4111.075008123208, 4237.63980061692, 4281.293586558245, 4345.695801293942, 3498.2478767065204, 3612.8012959286966, 3623.8912832615065, 4012.498437695288, 4216.641585465209, 746.1121265693807, 765.1315756616281, 776.6078130544153, 780.8906753054576, 785.4855069929206, 622.1942584353274, 637.8979363301942, 653.1867824558456, 655.8294843340766, 678.6437120511672, 7597.5821329826285, 8937.776555586031, 9394.95302523483, 9397.0, 9764.902350976541, 522.4462070205518, 612.1735656863199, 614.4211155398214, 616.608453631947, 660.0033948737441, 4493.842715504941, 4678.625709943196, 4685.156671799041, 4712.922577667957, 4729.929051064237, 128706.71293287135, 158053.0, 162082.0, 168302.0, 176152.0, 136145.0, 139015.0, 143149.0, 147562.0, 150138.0, 101676.0, 120096.0, 124405.0, 127287.72712272944, 129182.70817291707, 7616.543007419351, 8841.69054083104, 9047.502387368759, 9116.225120864801, 9197.632094716137, 67188.0, 67784.0, 68040.6597967007, 68353.3164668347, 70649.0, 101452.0, 102411.0, 104019.0, 107667.0, 110652.0, 11847.585334513251, 12150.635480935585, 12151.75696486083, 12162.75674486523, 12419.130660853654, 12554.372281385711, 12679.302638354979, 12827.0, 13054.477820887058, 13242.0, 11916.582919597773, 12078.758424831278, 12128.09039322072, 12400.19398739079, 12821.0, 12081.818772718241, 12944.546940857024, 14205.786913196103, 14330.856691432953, 14650.560483185522, 10486.528106235086, 12872.607155649093, 14012.089214201043, 14452.566423007327, 14492.637684057983, 10805.351678899291, 10897.509612067317, 11465.656030319104, 11647.242929209575, 12028.518859245882, 10107.79784404293, 10852.457377130953, 11689.123315751183, 11775.23460975034, 11810.409479525817], "value": 7881.860423753397, "unit": "score"}], "name": "dromaeo_css", "value": 7373.674729212169, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 110.0, 144.0, 120.0, 109.0, 108.0, 108.0, 141.0, 108.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 181.0, 185.0, 185.0, 183.0, 183.0, 185.0, 184.0, 186.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 82.0, 114.0, 60.0, 59.0, 59.0, 60.0, 83.0, 58.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 94.0, 71.0, 69.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 89.0, 84.0, 88.0, 85.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 97.0, 100.0, 147.0, 97.0, 96.0, 98.0, 98.0, 119.0, 161.0], "value": 111.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 95.0, 92.0, 126.0, 132.0, 92.0, 93.0, 95.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 53.0, 57.0, 59.0, 56.0, 58.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 72.0, 78.0, 75.0, 71.0, 68.0, 69.0, 70.0, 69.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 85.0, 83.0, 86.0, 86.0, 84.0, 83.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 122.0, 144.0, 143.0, 145.0, 145.0, 156.0, 200.0, 137.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 225.0, 187.0, 165.0, 163.0, 165.0, 163.0, 164.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 64.0, 67.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1465.7, "alertThreshold": 2.0}]} 03:31:41 INFO - Return code: 0 03:31:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:31:41 INFO - # TBPL SUCCESS # 03:31:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:31:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:31:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:31:41 INFO - 2016-10-18 03:31:41.306 screenresolution[1676:10922] starting screenresolution argv=screenresolution get 03:31:41 INFO - 2016-10-18 03:31:41.309 screenresolution[1676:10922] Display 0: 1600x1200x32@60 03:31:41 INFO - 2016-10-18 03:31:41.315 screenresolution[1677:10925] starting screenresolution argv=screenresolution list 03:31:41 INFO - Available Modes on Display 0 03:31:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:31:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:31:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:31:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:31:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:31:41 INFO - Intel Iris: 03:31:41 INFO - Chipset Model: Intel Iris 03:31:41 INFO - Type: GPU 03:31:41 INFO - Bus: Built-In 03:31:41 INFO - VRAM (Dynamic, Max): 1536 MB 03:31:41 INFO - Vendor: Intel (0x8086) 03:31:41 INFO - Device ID: 0x0a2e 03:31:41 INFO - Revision ID: 0x0009 03:31:41 INFO - Displays: 03:31:41 INFO - Display: 03:31:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:31:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:31:41 INFO - Display Serial Number: 1600x1200 60 03:31:41 INFO - Main Display: Yes 03:31:41 INFO - Mirror: Off 03:31:41 INFO - Online: Yes 03:31:41 INFO - Rotation: Supported 03:31:41 INFO - Return code: 0 03:31:41 INFO - Running post-action listener: _resource_record_post_action 03:31:41 INFO - [mozharness: 2016-10-18 10:31:41.553873Z] Finished run-tests step (success) 03:31:41 INFO - Running post-run listener: _resource_record_post_run 03:31:41 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 32828416; Write bytes: 664627712; Read time: 311; Write time: 2020 03:31:41 INFO - TinderboxPrint: CPU usage
53.1% 03:31:41 INFO - TinderboxPrint: I/O read bytes / time
32,828,416 / 311 03:31:41 INFO - TinderboxPrint: I/O write bytes / time
664,627,712 / 2,020 03:31:41 INFO - TinderboxPrint: CPU idle
2,267.0 (46.9%) 03:31:41 INFO - TinderboxPrint: CPU system
963.8 (19.9%) 03:31:41 INFO - TinderboxPrint: CPU user
1,602.9 (33.2%) 03:31:41 INFO - TinderboxPrint: Swap in / out
392,687,616 / 0 03:31:41 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360638976; Write bytes: 356829184; Read time: 27588; Write time: 711 03:31:41 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30825472; Write bytes: 296645120; Read time: 289; Write time: 1276 03:31:42 INFO - Running post-run listener: _upload_blobber_files 03:31:42 INFO - Blob upload gear active. 03:31:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:31:42 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:31:42 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:31:42 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:31:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:31:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:31:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:31:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:43 INFO - (blobuploader) - INFO - Done attempting. 03:31:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:31:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:44 INFO - (blobuploader) - INFO - Done attempting. 03:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:31:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:47 INFO - (blobuploader) - INFO - Done attempting. 03:31:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:47 INFO - Return code: 0 03:31:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c57214f883133c95d6a05657b8e32f4968dff6319d9fe9a65a7616e3577bb9b7a31e00305a5a2d94ca059e6b828de34119dbff84b3007b9635c1152d442ddd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50100db21260d67434be83e7e32e7d74510606306857867e6a64e381b0e5cd71ab874c323c23002ba79f82f6025dbe0923f70dedc4f1330a966ac042bd9df86d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35912b580dfbb38de2ecc59765a986f5e644e99bd2356553be15dc994eb273ab5e0124b0b6be7a0a4374d75035323248f9e4b29ffac4b483fb0dec8ddd29e54e"} 03:31:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:47 INFO - Contents: 03:31:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c57214f883133c95d6a05657b8e32f4968dff6319d9fe9a65a7616e3577bb9b7a31e00305a5a2d94ca059e6b828de34119dbff84b3007b9635c1152d442ddd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50100db21260d67434be83e7e32e7d74510606306857867e6a64e381b0e5cd71ab874c323c23002ba79f82f6025dbe0923f70dedc4f1330a966ac042bd9df86d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35912b580dfbb38de2ecc59765a986f5e644e99bd2356553be15dc994eb273ab5e0124b0b6be7a0a4374d75035323248f9e4b29ffac4b483fb0dec8ddd29e54e"} 03:31:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:47 INFO - Copying logs to upload dir... 03:31:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.248052 ========= master_lag: 1.25 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-18 03:31:48.637026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 03:31:48.640932) ========= 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.aqltpPO8TX/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.9cQpgNFxXk/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c57214f883133c95d6a05657b8e32f4968dff6319d9fe9a65a7616e3577bb9b7a31e00305a5a2d94ca059e6b828de34119dbff84b3007b9635c1152d442ddd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50100db21260d67434be83e7e32e7d74510606306857867e6a64e381b0e5cd71ab874c323c23002ba79f82f6025dbe0923f70dedc4f1330a966ac042bd9df86d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35912b580dfbb38de2ecc59765a986f5e644e99bd2356553be15dc994eb273ab5e0124b0b6be7a0a4374d75035323248f9e4b29ffac4b483fb0dec8ddd29e54e"} build_url:https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/CP6PlfloQfW8ZY127YBSXQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c57214f883133c95d6a05657b8e32f4968dff6319d9fe9a65a7616e3577bb9b7a31e00305a5a2d94ca059e6b828de34119dbff84b3007b9635c1152d442ddd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50100db21260d67434be83e7e32e7d74510606306857867e6a64e381b0e5cd71ab874c323c23002ba79f82f6025dbe0923f70dedc4f1330a966ac042bd9df86d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35912b580dfbb38de2ecc59765a986f5e644e99bd2356553be15dc994eb273ab5e0124b0b6be7a0a4374d75035323248f9e4b29ffac4b483fb0dec8ddd29e54e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 03:31:48.679338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:31:48.679674) ========= 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.aqltpPO8TX/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.9cQpgNFxXk/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005032 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:31:48.970773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 03:31:48.971081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 03:31:48.971517) ========= ========= Total master_lag: 1.64 =========