builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0059 starttime: 1489485775.35 results: success (0) buildid: 20170314012636 builduid: 4b7e0e65da894071b9b9f125f43e040a revision: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.351291) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.351808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.352083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.377128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.377472) ========= 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.xbPLvjkEjo/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.K37H2dOfCN/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-14 03:02:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.75M=0.001s 2017-03-14 03:02:55 (7.75 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.534342) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.534874) ========= 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.xbPLvjkEjo/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.K37H2dOfCN/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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.021687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:55.585121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 03:02:55.585642) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 --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 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xbPLvjkEjo/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.K37H2dOfCN/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-14 03:02:55,677 truncating revision to first 12 chars 2017-03-14 03:02:55,677 Setting DEBUG logging. 2017-03-14 03:02:55,678 attempt 1/10 2017-03-14 03:02:55,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/814932cca0c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 03:02:56,908 unpacking tar archive at: mozilla-aurora-814932cca0c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.482280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 03:02:57.092590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:57.092919) ========= script_repo_revision: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:57.093313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:57.093578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 03:02:57.113615) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-14 03:02:57.114019) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xbPLvjkEjo/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.K37H2dOfCN/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:02:57 INFO - MultiFileLogger online at 20170314 03:02:57 in /builds/slave/test 03:02:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:02:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:02:57 INFO - {'append_to_log': False, 03:02:57 INFO - 'base_work_dir': '/builds/slave/test', 03:02:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:02:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:02:57 INFO - 'branch': 'Mozilla-Aurora', 03:02:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:02:57 INFO - 'config_files': ('talos/mac_config.py',), 03:02:57 INFO - 'default_actions': ('clobber', 03:02:57 INFO - 'read-buildbot-config', 03:02:57 INFO - 'download-and-extract', 03:02:57 INFO - 'populate-webroot', 03:02:57 INFO - 'create-virtualenv', 03:02:57 INFO - 'install', 03:02:57 INFO - 'run-tests'), 03:02:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:02:57 INFO - 'download_minidump_stackwalk': True, 03:02:57 INFO - 'download_symbols': 'ondemand', 03:02:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:02:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:02:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:02:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:02:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:02:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:02:57 INFO - 'gecko_profile': False, 03:02:57 INFO - 'gecko_profile_interval': 0, 03:02:57 INFO - 'installer_path': 'installer.exe', 03:02:57 INFO - 'log_level': 'info', 03:02:57 INFO - 'log_name': 'talos', 03:02:57 INFO - 'log_to_console': True, 03:02:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:02:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:02:57 INFO - 'opt_config_files': (), 03:02:57 INFO - 'pip_index': False, 03:02:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:57 INFO - 'cmd': ('bash', 03:02:57 INFO - '-c', 03:02:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:57 INFO - 'enabled': True, 03:02:57 INFO - 'halt_on_failure': False, 03:02:57 INFO - 'name': 'check_screen_resolution'},), 03:02:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:57 INFO - 'cmd': ('bash', 03:02:57 INFO - '-c', 03:02:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:57 INFO - 'enabled': True, 03:02:57 INFO - 'halt_on_failure': False, 03:02:57 INFO - 'name': 'check_screen_resolution'},), 03:02:57 INFO - 'run_cmd_checks_enabled': True, 03:02:57 INFO - 'suite': 'dromaeojs-e10s', 03:02:57 INFO - 'system_bits': '32', 03:02:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:02:57 INFO - 'title': 't-yosemite-r7-0059', 03:02:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:02:57 INFO - 'use_talos_json': True, 03:02:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:02:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:02:57 INFO - 'work_dir': 'build'} 03:02:57 INFO - [mozharness: 2017-03-14 10:02:57.325158Z] Running clobber step. 03:02:57 INFO - Running pre-action listener: _resource_record_pre_action 03:02:57 INFO - Running main action method: clobber 03:02:57 INFO - rmtree: /builds/slave/test/build 03:02:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:02:59 INFO - Running post-action listener: _resource_record_post_action 03:02:59 INFO - [mozharness: 2017-03-14 10:02:59.330241Z] Finished clobber step (success) 03:02:59 INFO - [mozharness: 2017-03-14 10:02:59.330373Z] Running read-buildbot-config step. 03:02:59 INFO - Running pre-action listener: _resource_record_pre_action 03:02:59 INFO - Running main action method: read_buildbot_config 03:02:59 INFO - Using buildbot properties: 03:02:59 INFO - { 03:02:59 INFO - "project": "", 03:02:59 INFO - "product": "firefox", 03:02:59 INFO - "script_repo_revision": "production", 03:02:59 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:02:59 INFO - "repository": "", 03:02:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:02:59 INFO - "buildid": "20170314012636", 03:02:59 INFO - "pgo_build": "False", 03:02:59 INFO - "basedir": "/builds/slave/test", 03:02:59 INFO - "buildnumber": 16, 03:02:59 INFO - "slavename": "t-yosemite-r7-0059", 03:02:59 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:02:59 INFO - "platform": "yosemite_r7", 03:02:59 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:02:59 INFO - "branch": "mozilla-aurora", 03:02:59 INFO - "repo_path": "releases/mozilla-aurora", 03:02:59 INFO - "revision": "814932cca0c405b3f95e15fa9b6d4013ccb8cfb1", 03:02:59 INFO - "stage_platform": "macosx64", 03:02:59 INFO - "builduid": "4b7e0e65da894071b9b9f125f43e040a", 03:02:59 INFO - "slavebuilddir": "test" 03:02:59 INFO - } 03:02:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 03:02:59 INFO - Running post-action listener: _resource_record_post_action 03:02:59 INFO - [mozharness: 2017-03-14 10:02:59.334027Z] Finished read-buildbot-config step (success) 03:02:59 INFO - [mozharness: 2017-03-14 10:02:59.334216Z] Running download-and-extract step. 03:02:59 INFO - Running pre-action listener: _resource_record_pre_action 03:02:59 INFO - Running main action method: download_and_extract 03:02:59 INFO - mkdir: /builds/slave/test/build/tests 03:02:59 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:02:59 INFO - trying https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 03:02:59 INFO - Downloading https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:02:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 03:03:00 INFO - Downloaded 1199 bytes. 03:03:00 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 03:03:00 INFO - Using the following test package requirements: 03:03:00 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:03:00 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 03:03:00 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 03:03:00 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'jsshell-mac.zip'], 03:03:00 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 03:03:00 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 03:03:00 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 03:03:00 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 03:03:00 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 03:03:00 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 03:03:00 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 03:03:00 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:03:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:03:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:00 INFO - Fetch https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:03:01 INFO - Expected file size: 51779789 03:03:01 INFO - Obtained file size: 51779789 03:03:18 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:03:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 03:03:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:03:18 INFO - Fetch https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 03:03:20 INFO - Expected file size: 51779789 03:03:20 INFO - Obtained file size: 51779789 03:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 03:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 03:03:37 INFO - Expected file size: 14404424 03:03:37 INFO - Obtained file size: 14404424 03:03:37 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:03:37 INFO - trying https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:03:37 INFO - Downloading https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 03:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 03:03:39 INFO - Downloaded 74622826 bytes. 03:03:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:03:39 INFO - mkdir: /builds/slave/test/properties 03:03:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:39 INFO - Contents: 03:03:39 INFO - build_url:https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 03:03:40 INFO - Running post-action listener: _resource_record_post_action 03:03:40 INFO - Running post-action listener: set_extra_try_arguments 03:03:40 INFO - [mozharness: 2017-03-14 10:03:40.081069Z] Finished download-and-extract step (success) 03:03:40 INFO - [mozharness: 2017-03-14 10:03:40.081228Z] Running populate-webroot step. 03:03:40 INFO - Running pre-action listener: _resource_record_pre_action 03:03:40 INFO - Running main action method: populate_webroot 03:03:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:40 INFO - '--tppagecycles', 03:03:40 INFO - '7'], 03:03:40 INFO - 'tests': ['tsvgm']}}, 03:03:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['damp', 'tps']}, 03:03:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'tests': ['damp', 'tps']}, 03:03:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['dromaeo_dom']}, 03:03:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['basic_compositor_video']}, 03:03:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:03:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['a11yr', 03:03:40 INFO - 'ts_paint', 03:03:40 INFO - 'tpaint', 03:03:40 INFO - 'sessionrestore', 03:03:40 INFO - 'sessionrestore_no_auto_restore', 03:03:40 INFO - 'tabpaint']}, 03:03:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tsvgx', 03:03:40 INFO - 'tsvgr_opacity', 03:03:40 INFO - 'tart', 03:03:40 INFO - 'tscrollx', 03:03:40 INFO - 'cart', 03:03:40 INFO - 'tsvg_static']}, 03:03:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:40 INFO - 'tsvgr_opacity', 03:03:40 INFO - 'tart', 03:03:40 INFO - 'tscrollx', 03:03:40 INFO - 'cart', 03:03:40 INFO - 'tsvg_static']}, 03:03:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s'], 03:03:40 INFO - 'tests': ['tp5o']}, 03:03:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:03:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'talos_options': ['--disable-e10s', 03:03:40 INFO - '--xperf_path', 03:03:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:40 INFO - 'tests': ['tp5n']}, 03:03:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:03:40 INFO - 'talos_options': ['--xperf_path', 03:03:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:40 INFO - 'tests': ['tp5n']}}, 03:03:40 INFO - 'talos.zip': {'path': '', 03:03:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:40 INFO - Running post-action listener: _resource_record_post_action 03:03:40 INFO - [mozharness: 2017-03-14 10:03:40.099998Z] Finished populate-webroot step (success) 03:03:40 INFO - [mozharness: 2017-03-14 10:03:40.100133Z] Running create-virtualenv step. 03:03:40 INFO - Running pre-action listener: _resource_record_pre_action 03:03:40 INFO - Running main action method: create_virtualenv 03:03:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:03:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:40 INFO - Using real prefix '/tools/python27' 03:03:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:40 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:43 INFO - Installing pip.................done. 03:03:43 INFO - Return code: 0 03:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:03:44 INFO - Reading from file tmpfile_stdout 03:03:44 INFO - Output received: 03:03:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:03:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:44 INFO - 'HOME': '/Users/cltbld', 03:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:44 INFO - 'LOGNAME': 'cltbld', 03:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:44 INFO - 'MOZ_NO_REMOTE': '1', 03:03:44 INFO - 'NO_EM_RESTART': '1', 03:03:44 INFO - 'PAGER': '/bin/cat', 03:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:44 INFO - 'PWD': '/builds/slave/test', 03:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:44 INFO - 'SHELL': '/bin/bash', 03:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:03:44 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:44 INFO - 'USER': 'cltbld', 03:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:44 INFO - 'XPC_FLAGS': '0x0', 03:03:44 INFO - 'XPC_SERVICE_NAME': '0', 03:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:03:44 INFO - Cleaning up... 03:03:44 INFO - Return code: 0 03:03:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:03:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:03:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:44 INFO - 'HOME': '/Users/cltbld', 03:03:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:44 INFO - 'LOGNAME': 'cltbld', 03:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:44 INFO - 'MOZ_NO_REMOTE': '1', 03:03:44 INFO - 'NO_EM_RESTART': '1', 03:03:44 INFO - 'PAGER': '/bin/cat', 03:03:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:44 INFO - 'PWD': '/builds/slave/test', 03:03:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:44 INFO - 'SHELL': '/bin/bash', 03:03:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:03:44 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:03:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:44 INFO - 'USER': 'cltbld', 03:03:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:44 INFO - 'XPC_FLAGS': '0x0', 03:03:44 INFO - 'XPC_SERVICE_NAME': '0', 03:03:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:44 INFO - Downloading/unpacking psutil>=3.1.1 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:48 INFO - Installing collected packages: psutil 03:03:48 INFO - Running setup.py install for psutil 03:03:48 INFO - building 'psutil._psutil_osx' extension 03:03:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:03:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:03:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:03:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:03:48 INFO - building 'psutil._psutil_posix' extension 03:03:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:03:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:03:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:03:48 INFO - ^ 03:03:48 INFO - 1 warning generated. 03:03:48 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:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:49 INFO - Successfully installed psutil 03:03:49 INFO - Cleaning up... 03:03:49 INFO - Return code: 0 03:03:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:49 INFO - 'HOME': '/Users/cltbld', 03:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:49 INFO - 'LOGNAME': 'cltbld', 03:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:49 INFO - 'MOZ_NO_REMOTE': '1', 03:03:49 INFO - 'NO_EM_RESTART': '1', 03:03:49 INFO - 'PAGER': '/bin/cat', 03:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:49 INFO - 'PWD': '/builds/slave/test', 03:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:49 INFO - 'SHELL': '/bin/bash', 03:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:03:49 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:49 INFO - 'USER': 'cltbld', 03:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:49 INFO - 'XPC_FLAGS': '0x0', 03:03:49 INFO - 'XPC_SERVICE_NAME': '0', 03:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:52 INFO - Installing collected packages: mozsystemmonitor 03:03:52 INFO - Running setup.py install for mozsystemmonitor 03:03:52 INFO - Successfully installed mozsystemmonitor 03:03:52 INFO - Cleaning up... 03:03:52 INFO - Return code: 0 03:03:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:03:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:03:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:53 INFO - 'HOME': '/Users/cltbld', 03:03:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:53 INFO - 'LOGNAME': 'cltbld', 03:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:53 INFO - 'MOZ_NO_REMOTE': '1', 03:03:53 INFO - 'NO_EM_RESTART': '1', 03:03:53 INFO - 'PAGER': '/bin/cat', 03:03:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:53 INFO - 'PWD': '/builds/slave/test', 03:03:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:53 INFO - 'SHELL': '/bin/bash', 03:03:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:03:53 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:03:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:53 INFO - 'USER': 'cltbld', 03:03:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:53 INFO - 'XPC_FLAGS': '0x0', 03:03:53 INFO - 'XPC_SERVICE_NAME': '0', 03:03:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:03:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:56 INFO - Downloading functools32-3.2.3-2.tar.gz 03:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:03:56 INFO - warning: no files found matching '*.txt' 03:03:56 INFO - no previously-included directories found matching 'build' 03:03:56 INFO - no previously-included directories found matching 'dist' 03:03:56 INFO - no previously-included directories found matching '.git*' 03:03:56 INFO - Installing collected packages: jsonschema, functools32 03:03:56 INFO - Running setup.py install for functools32 03:03:57 INFO - warning: no files found matching '*.txt' 03:03:57 INFO - no previously-included directories found matching 'build' 03:03:57 INFO - no previously-included directories found matching 'dist' 03:03:57 INFO - no previously-included directories found matching '.git*' 03:03:57 INFO - Successfully installed jsonschema functools32 03:03:57 INFO - Cleaning up... 03:03:57 INFO - Return code: 0 03:03:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:03:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:03:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:57 INFO - 'HOME': '/Users/cltbld', 03:03:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:57 INFO - 'LOGNAME': 'cltbld', 03:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:57 INFO - 'MOZ_NO_REMOTE': '1', 03:03:57 INFO - 'NO_EM_RESTART': '1', 03:03:57 INFO - 'PAGER': '/bin/cat', 03:03:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:57 INFO - 'PWD': '/builds/slave/test', 03:03:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:57 INFO - 'SHELL': '/bin/bash', 03:03:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:03:57 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:03:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:57 INFO - 'USER': 'cltbld', 03:03:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:57 INFO - 'XPC_FLAGS': '0x0', 03:03:57 INFO - 'XPC_SERVICE_NAME': '0', 03:03:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:03:57 INFO - Cleaning up... 03:03:57 INFO - Return code: 0 03:03:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:03:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:03:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:57 INFO - 'HOME': '/Users/cltbld', 03:03:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:57 INFO - 'LOGNAME': 'cltbld', 03:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:57 INFO - 'MOZ_NO_REMOTE': '1', 03:03:57 INFO - 'NO_EM_RESTART': '1', 03:03:57 INFO - 'PAGER': '/bin/cat', 03:03:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:57 INFO - 'PWD': '/builds/slave/test', 03:03:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:57 INFO - 'SHELL': '/bin/bash', 03:03:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:03:57 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:03:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:57 INFO - 'USER': 'cltbld', 03:03:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:57 INFO - 'XPC_FLAGS': '0x0', 03:03:57 INFO - 'XPC_SERVICE_NAME': '0', 03:03:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:04:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:01 INFO - Downloading docopt-0.6.1.tar.gz 03:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:04:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:04:01 INFO - Running setup.py install for blobuploader 03:04:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:04:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:04:01 INFO - Running setup.py install for requests 03:04:02 INFO - Running setup.py install for docopt 03:04:02 INFO - Successfully installed blobuploader requests docopt 03:04:02 INFO - Cleaning up... 03:04:02 INFO - Return code: 0 03:04:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:02 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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:04:02 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:04:02 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:04:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:04:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:02 INFO - 'HOME': '/Users/cltbld', 03:04:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:02 INFO - 'LOGNAME': 'cltbld', 03:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:02 INFO - 'MOZ_NO_REMOTE': '1', 03:04:02 INFO - 'NO_EM_RESTART': '1', 03:04:02 INFO - 'PAGER': '/bin/cat', 03:04:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:02 INFO - 'PWD': '/builds/slave/test', 03:04:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:02 INFO - 'SHELL': '/bin/bash', 03:04:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:04:02 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:04:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:02 INFO - 'USER': 'cltbld', 03:04:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:02 INFO - 'XPC_FLAGS': '0x0', 03:04:02 INFO - 'XPC_SERVICE_NAME': '0', 03:04:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:02 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-lk5Vpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:02 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-KQ7YNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pBZgpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-N9iqiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-g2l8wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-egZ4zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-XhQQ4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-aRRSwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-LqDHWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-SXFT_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-xoVoSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:03 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-YMWmkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:04 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-bExi6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:04 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-fBRyHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:04 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-0faVa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:04 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-QBPcNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:04 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-5ltmWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:04 INFO - Running setup.py install for manifestparser 03:04:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:04 INFO - Running setup.py install for mozcrash 03:04:04 INFO - Running setup.py install for mozdebug 03:04:05 INFO - Running setup.py install for mozdevice 03:04:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Running setup.py install for mozfile 03:04:05 INFO - Running setup.py install for mozhttpd 03:04:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Running setup.py install for mozinfo 03:04:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Running setup.py install for mozInstall 03:04:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:05 INFO - Running setup.py install for mozleak 03:04:05 INFO - Running setup.py install for mozlog 03:04:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:06 INFO - Running setup.py install for moznetwork 03:04:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:06 INFO - Running setup.py install for mozprocess 03:04:06 INFO - Running setup.py install for mozprofile 03:04:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:06 INFO - Running setup.py install for mozrunner 03:04:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:06 INFO - Running setup.py install for mozscreenshot 03:04:06 INFO - Running setup.py install for moztest 03:04:07 INFO - Running setup.py install for mozversion 03:04:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:07 INFO - Cleaning up... 03:04:07 INFO - Return code: 0 03:04:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:04:07 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:04:07 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:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:07 INFO - 'HOME': '/Users/cltbld', 03:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:07 INFO - 'LOGNAME': 'cltbld', 03:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:07 INFO - 'MOZ_NO_REMOTE': '1', 03:04:07 INFO - 'NO_EM_RESTART': '1', 03:04:07 INFO - 'PAGER': '/bin/cat', 03:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:07 INFO - 'PWD': '/builds/slave/test', 03:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:07 INFO - 'SHELL': '/bin/bash', 03:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:04:07 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:07 INFO - 'USER': 'cltbld', 03:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:07 INFO - 'XPC_FLAGS': '0x0', 03:04:07 INFO - 'XPC_SERVICE_NAME': '0', 03:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:07 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-6hsKor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:07 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Xf4IKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:07 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-jEZfQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:07 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-ErVooe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:07 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-mEyyjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-Gm4IYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-NKwzGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-X4rD8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-QQIgKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pemC8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-wnBj2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-pT5GPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-DePm_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:08 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:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-3EHEQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:08 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-NBb74J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:09 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:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:09 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-VTND1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:09 INFO - Running setup.py (path:/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/pip-hGmKJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:09 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:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:09 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:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:09 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:04:09 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:04:09 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:04:09 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:04:09 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:04:09 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:04:11 INFO - Downloading blessings-1.6.tar.gz 03:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:12 INFO - Installing collected packages: blessings 03:04:12 INFO - Running setup.py install for blessings 03:04:12 INFO - Successfully installed blessings 03:04:12 INFO - Cleaning up... 03:04:12 INFO - Return code: 0 03:04:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:04:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:12 INFO - Reading from file tmpfile_stdout 03:04:12 INFO - Current package versions: 03:04:12 INFO - blessings == 1.6 03:04:12 INFO - blobuploader == 1.2.4 03:04:12 INFO - docopt == 0.6.1 03:04:12 INFO - functools32 == 3.2.3-2 03:04:12 INFO - jsonschema == 2.5.1 03:04:12 INFO - manifestparser == 1.1 03:04:12 INFO - mozInstall == 1.12 03:04:12 INFO - mozcrash == 1.0 03:04:12 INFO - mozdebug == 0.1 03:04:12 INFO - mozdevice == 0.49 03:04:12 INFO - mozfile == 1.2 03:04:12 INFO - mozhttpd == 0.7 03:04:12 INFO - mozinfo == 0.9 03:04:12 INFO - mozleak == 0.1 03:04:12 INFO - mozlog == 3.4 03:04:12 INFO - moznetwork == 0.27 03:04:12 INFO - mozprocess == 0.25 03:04:12 INFO - mozprofile == 0.28 03:04:12 INFO - mozrunner == 6.13 03:04:12 INFO - mozscreenshot == 0.1 03:04:12 INFO - mozsystemmonitor == 0.3 03:04:12 INFO - moztest == 0.8 03:04:12 INFO - mozversion == 1.4 03:04:12 INFO - psutil == 3.1.1 03:04:12 INFO - requests == 1.2.3 03:04:12 INFO - wsgiref == 0.1.2 03:04:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:12 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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:04:12 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:04:12 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:04:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:04:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:12 INFO - 'HOME': '/Users/cltbld', 03:04:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:12 INFO - 'LOGNAME': 'cltbld', 03:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:12 INFO - 'MOZ_NO_REMOTE': '1', 03:04:12 INFO - 'NO_EM_RESTART': '1', 03:04:12 INFO - 'PAGER': '/bin/cat', 03:04:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:12 INFO - 'PWD': '/builds/slave/test', 03:04:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:12 INFO - 'SHELL': '/bin/bash', 03:04:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:04:12 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:04:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:12 INFO - 'USER': 'cltbld', 03:04:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:12 INFO - 'XPC_FLAGS': '0x0', 03:04:12 INFO - 'XPC_SERVICE_NAME': '0', 03:04:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 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:04:12 INFO - Cleaning up... 03:04:12 INFO - Return code: 0 03:04:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:12 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 0x10e797b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e79a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98e3c61960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, '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.xbPLvjkEjo/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.K37H2dOfCN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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:04:12 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:04:12 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:04:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:04:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:12 INFO - 'HOME': '/Users/cltbld', 03:04:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:12 INFO - 'LOGNAME': 'cltbld', 03:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:12 INFO - 'MOZ_NO_REMOTE': '1', 03:04:12 INFO - 'NO_EM_RESTART': '1', 03:04:12 INFO - 'PAGER': '/bin/cat', 03:04:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:12 INFO - 'PWD': '/builds/slave/test', 03:04:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:12 INFO - 'SHELL': '/bin/bash', 03:04:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:04:12 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:04:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:12 INFO - 'USER': 'cltbld', 03:04:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:12 INFO - 'XPC_FLAGS': '0x0', 03:04:12 INFO - 'XPC_SERVICE_NAME': '0', 03:04:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:04:13 INFO - Cleaning up... 03:04:13 INFO - Return code: 0 03:04:13 INFO - Running post-action listener: _resource_record_post_action 03:04:13 INFO - Running post-action listener: _start_resource_monitoring 03:04:13 INFO - Starting resource monitoring. 03:04:13 INFO - [mozharness: 2017-03-14 10:04:13.126199Z] Finished create-virtualenv step (success) 03:04:13 INFO - [mozharness: 2017-03-14 10:04:13.127171Z] Running install step. 03:04:13 INFO - Running pre-action listener: _resource_record_pre_action 03:04:13 INFO - Running main action method: install 03:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:13 INFO - Reading from file tmpfile_stdout 03:04:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:04:13 INFO - Reading from file tmpfile_stdout 03:04:13 INFO - Output received: 03:04:13 INFO - Usage: mozinstall [options] installer 03:04:13 INFO - Options: 03:04:13 INFO - -h, --help show this help message and exit 03:04:13 INFO - -d DEST, --destination=DEST 03:04:13 INFO - Directory to install application into. [default: 03:04:13 INFO - "/builds/slave/test"] 03:04:13 INFO - --app=APP Application being installed. [default: firefox] 03:04:13 INFO - mkdir: /builds/slave/test/build/application 03:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:04:33 INFO - Reading from file tmpfile_stdout 03:04:33 INFO - Output received: 03:04:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:04:33 INFO - Running post-action listener: _resource_record_post_action 03:04:33 INFO - [mozharness: 2017-03-14 10:04:33.563558Z] Finished install step (success) 03:04:33 INFO - [mozharness: 2017-03-14 10:04:33.563691Z] Running run-tests step. 03:04:33 INFO - Running pre-action listener: _resource_record_pre_action 03:04:33 INFO - Running main action method: run_tests 03:04:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:04:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:04:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:04:33 INFO - 2017-03-14 03:04:33.578 screenresolution[1945:15391] starting screenresolution argv=screenresolution get 03:04:33 INFO - 2017-03-14 03:04:33.580 screenresolution[1945:15391] Display 0: 1600x1200x32@60 03:04:33 INFO - 2017-03-14 03:04:33.586 screenresolution[1946:15393] starting screenresolution argv=screenresolution list 03:04:33 INFO - Available Modes on Display 0 03:04:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:04:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:04:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:04:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:04:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:04:33 INFO - Intel Iris: 03:04:33 INFO - Chipset Model: Intel Iris 03:04:33 INFO - Type: GPU 03:04:33 INFO - Bus: Built-In 03:04:33 INFO - VRAM (Dynamic, Max): 1536 MB 03:04:33 INFO - Vendor: Intel (0x8086) 03:04:33 INFO - Device ID: 0x0a2e 03:04:33 INFO - Revision ID: 0x0009 03:04:33 INFO - Displays: 03:04:33 INFO - Display: 03:04:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:04:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:04:33 INFO - Display Serial Number: 1600x1200 60 03:04:33 INFO - Main Display: Yes 03:04:33 INFO - Mirror: Off 03:04:33 INFO - Online: Yes 03:04:33 INFO - Rotation: Supported 03:04:33 INFO - Return code: 0 03:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:33 INFO - Python 2.7.3 03:04:33 INFO - Return code: 0 03:04:33 INFO - grabbing minidump binary from tooltool 03:04:33 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:04:33 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 0x10e575d30>, '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 0x10e49cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04:33 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:04:33 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:04:33 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:04:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:33 INFO - Return code: 0 03:04:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:04:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:33 INFO - ENV: RUST_BACKTRACE is now 1 03:04:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:04:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:04:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xbPLvjkEjo/Render', 03:04:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:04:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:04:33 INFO - 'HOME': '/Users/cltbld', 03:04:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:04:33 INFO - 'LOGNAME': 'cltbld', 03:04:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:33 INFO - 'MOZ_NO_REMOTE': '1', 03:04:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:33 INFO - 'NO_EM_RESTART': '1', 03:04:33 INFO - 'PAGER': '/bin/cat', 03:04:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:33 INFO - 'PWD': '/builds/slave/test', 03:04:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:04:33 INFO - 'RUST_BACKTRACE': '1', 03:04:33 INFO - 'SHELL': '/bin/bash', 03:04:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K37H2dOfCN/Listeners', 03:04:33 INFO - 'TMPDIR': '/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/', 03:04:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:04:33 INFO - 'USER': 'cltbld', 03:04:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:04:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:33 INFO - 'XPC_FLAGS': '0x0', 03:04:33 INFO - 'XPC_SERVICE_NAME': '0', 03:04:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:04:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:04:34 INFO - mozversion application_buildid: 20170314012636 03:04:34 INFO - mozversion application_changeset: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 03:04:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:04:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:34 INFO - mozversion application_name: Firefox 03:04:34 INFO - mozversion application_remotingname: firefox-dev 03:04:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:34 INFO - mozversion application_vendor: Mozilla 03:04:34 INFO - mozversion application_version: 54.0a2 03:04:34 INFO - mozversion platform_buildid: 20170314012636 03:04:34 INFO - mozversion platform_changeset: 814932cca0c405b3f95e15fa9b6d4013ccb8cfb1 03:04:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:34 INFO - mozversion platform_version: 54.0a2 03:04:34 INFO - using testdate: 1489485874 03:04:34 INFO - actual date: 1489485874 03:04:34 INFO - starting webserver on 'localhost:52908' 03:04:34 INFO - SUITE-START | Running 2 tests 03:04:34 INFO - TEST-START | dromaeo_css 03:04:34 INFO - operating with platform_type : mac_ 03:04:34 INFO - Initialising browser for dromaeo_css test... 03:04:34 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpcpwQPa/profile http://localhost:52908/getInfo.html) 03:04:36 INFO - PROCESS | 1956 | 2017-03-14 03:04:36.966 plugin-container[1958:15558] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 03:04:36 INFO - PROCESS | 1956 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:36 INFO - PROCESS | 1956 | 2017-03-14 03:04:36.969 plugin-container[1958:15558] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484b, name = 'com.apple.CFPasteboardClient' 03:04:36 INFO - PROCESS | 1956 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:36 INFO - PROCESS | 1956 | 2017-03-14 03:04:36.969 plugin-container[1958:15558] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:04:37 INFO - PROCESS | 1956 | __metrics Screen width/height:1600/1200 03:04:37 INFO - PROCESS | 1956 | colorDepth:24 03:04:37 INFO - PROCESS | 1956 | Browser inner width/height: 1024/689 03:04:37 INFO - PROCESS | 1956 | __metrics 03:04:37 ERROR - PROCESS | 1956 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 03:04:37 INFO - TEST-INFO | 1956: exit 0 03:04:37 INFO - Browser initialized. 03:04:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:37 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpcpwQPa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:40 INFO - PROCESS | 1959 | 2017-03-14 03:04:40.287 plugin-container[1960:15687] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 03:04:40 INFO - PROCESS | 1959 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:40 INFO - PROCESS | 1959 | 2017-03-14 03:04:40.288 plugin-container[1960:15687] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:04:40 INFO - PROCESS | 1959 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:04:40 INFO - PROCESS | 1959 | 2017-03-14 03:04:40.288 plugin-container[1960:15687] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:04:50 INFO - PROCESS | 1959 | RSS: Main: 220655616 03:04:50 INFO - PROCESS | 1959 | 03:07:54 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52908/tests/dromaeo/cssquery-ext.html) 03:07:55 INFO - PROCESS | 1959 | RSS: Main: 243834880 03:07:55 INFO - PROCESS | 1959 | 03:09:38 INFO - PROCESS | 1959 | ************************* 03:09:38 INFO - PROCESS | 1959 | A coding exception was thrown and uncaught in a Task. 03:09:38 INFO - PROCESS | 1959 | 03:09:38 ERROR - PROCESS | 1959 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:09:38 INFO - PROCESS | 1959 | Full stack: 03:09:38 INFO - PROCESS | 1959 | ************************* 03:10:57 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-ext.html (next: http://localhost:52908/tests/dromaeo/cssquery-jquery.html) 03:10:58 INFO - PROCESS | 1959 | RSS: Main: 250753024 03:10:58 INFO - PROCESS | 1959 | 03:14:00 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52908/tests/dromaeo/cssquery-mootools.html) 03:14:01 INFO - PROCESS | 1959 | RSS: Main: 257183744 03:14:01 INFO - PROCESS | 1959 | 03:17:03 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52908/tests/dromaeo/cssquery-prototype.html) 03:17:03 INFO - PROCESS | 1959 | RSS: Main: 254623744 03:17:03 INFO - PROCESS | 1959 | 03:20:06 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52908/tests/dromaeo/cssquery-yui.html) 03:20:07 INFO - PROCESS | 1959 | RSS: Main: 260898816 03:20:07 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-yui.html (next: http://localhost:52908/tests/dromaeo/cssquery-dojo.html) 03:23:10 INFO - PROCESS | 1959 | RSS: Main: 257191936 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | __start_tp_report 03:23:10 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 03:23:10 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 03:23:10 INFO - PROCESS | 1959 | |i|pagename|runs| 03:23:10 INFO - PROCESS | 1959 | |0;dojo.html;3419.7948123112606;3432.330695514374;3447.1037530242147;3464.61889192189;3465.5668041494814;5925.288965324162;6003.429674180951;6044.758209671619;6055.60638558494;6057.727402266897;6026.6685332306815;6075.2405949256345;6115.48018418435;6117.755289788403;6126.509879209663;5370.248165256867;5431.83704488864;5445.237666726642;5454;5527.640703354289;5505.6696598204035;5508.091164957777;5514.6139770216105;5528.44715528448;5568.248286481314;5259.3951695555115;5308.416074231832;5392.325959255093;5503.724813759296;5520.1443776214755;5420.186971954199;5453.454654534555;5494.120940649517;5522.144067669517;5574.777008919638;5315.893682126336;5432.320959880015;5436.646617969819;5437.700926449043;5463.7814487420455;5726.9713651431475;6079.878402431971;6094.512439004913;6147.354527774609;6156.076588511714;6281.152044473984;6283.214598175228;6317.842053948642;6324.841878953017;6344.904826427607;6445.001024841157;6446.033095035736;6450.451711604519;6455.709493072823;6463.06285588587;6187.907181392283;6206.193194884681;6218.937810621881;6225.190725205694;6232.3144454110015;6283.937160628335;6324.841878953063;6502.2197336318995;6531.0856480092825;6601.2738598754095;6310.211223597051;6335.208098987627;6354.332795056453;6355.396237357444;6368.617882927039;6316.526260530479;6418.8716225675225;6420.839479012969;6428.100065990765;6429.646369449725;6250.093736408196;6285.8742825143245;6369.394907483782;6372.6495042773095;6380.361963803675;6254.655993920378;6259.123722678829;6280.466160376419;6319;6322.968385158045;5055.823046193365;5136.460671629425;5186.429492755794;5192.4807519248525;5208.088584497697;4273.764942928106;4278.315469524923;4570.268756998864;4591;4596.931046034312;5943.673097979567;6138.631682099089;6210.565260431817;6220.875582488416;6223.315435302113;6301.40136687014;6303.905441418382;6306.2747784004505;6324.051392291101;6361.745530178741;6158.107074474266;6170.876582468325;6198.411150940653;6207.472364848948;6219.160413344141;5715.2855893013375;5736.340320863071;5737.913931291034;5745.999999999916;5770;6332.461740752087;6355.269144048493;6534.281229064704;6562.573432726857;6696.7656132035145;6429.839254018687;6433.099366088845;6447.323031081669;6461.224653041665;6480.287168411565;6624.56940298879;6705.396514313735;6728.3271672832325;6729.5625784323865;6747.730090796509;6252.9062064069985;6269.216347956505;6271.310155882758;6284.591501552384;6383.457406120346;6320.810375688737;6427.485801135991;6455.677216139268;6469.547131700736;6492.220933488012;6328.841778955563;6329.6518691470565;6330.525210609315;6330.936690633035;6368.108464814837;6149.7847575334645;6206.627602343874;6252.749890004349;6284.622922624657;6332.810015699536;6125.203723516092;6152;6288;6301.684915754286;6318.052292156213;6317.905231421624;6340.922043252566;6344.111824344688;6348.587341822767;6349.984002559569;6035.064564992434;6043.395660433922;6159;6192.690365481798;6204.410580994799 03:23:10 INFO - PROCESS | 1959 | |1;ext.html;724.8151721311067;746.1941103608103;833.4874052457739;953.0802775321813;959.4291396619009;38070.857874263784;38878;40429.393559096636;40470.392944105864;40518.39222411666;39235.41146882799;39341.409878851766;39379.21241575167;39451.60548394515;39543.604563954425;7952.085510166333;8100.959495202515;10553.577856885715;10879.401632910187;11046.779064418706;10756.838647420294;10861.076808471289;10870.565177392895;10873;10884.292520986111;10812.837807432894;10874.836877446845;10894.128469722444;10907;10911.345319280828;10852.511636976355;10871.945640271828;10878.619248326271;10881.238313318032;10896.564137434492;10629.5216715248;10690.51892664832;10694.946525267402;10716.249862509627;10794.298370605886;27876.44247115046;34690.653093468994;34738.131546711535;34755.826220868985;34783.82608086969;3718.7396882218254;3790.7725536467624;3792.7345085844004;3795.8291876865333;3801.1067399161175;25114.12100576471;25156.24531264065;25246.116385926587;25555.211135220543;26383.229760875023;2521.8612976286295;3106.1147572941827;3115.2056225662536;3132.2482604174834;3226.451503244454;289048;332254.99999999756;334368;341248;402775.98612007045;41775.58224417717;41878.79060604677;42034.369484457755;42158.367624485654;42194.73415797531;44798;44899.77550112294;44902.77548612301;44970.75146242675;45066.32400513995;13542.45830166802;13626.659333516742;13647.727045459034;13648;13653;11626.53493860253;11783.469743861548;12049.096317776202;12080.818787718192;12089;9213.447193168431;9864.802703945881;10396.636117735843;12122.030237580972;12183.695407614881;5060.671056381397;5678.5741069419955;5766.34748015909;5785.27684039495;5796.913046304308;1084.7830433913248;1103.3104309806372;1105.5467258424007;1110.9277896936674;1160.1762748448527;24089.156879509133;27126.74821691823;27616.171514854588;29375.55936660952;29469.55795663024;873.6767396063498;933.9533023348805;1012.5747186181674;1081.9404932728619;1172.976540469186;14518.896083934063;15526.990745601499;15635.296411661502;15704.214789260719;15889.52331430059;482375;482477.58761205967;485610;485984;486249;57353.71323143441;57674;58090;58124.4187558119;58294.54263643358;1460.1531111955042;1473.734727748994;1495.1477657735204;1500.2423775993054;1506.6760646461064;23197.304080877602;28356;29517.966871159406;29797.702022979494;29935.850320749127;49161.2625810606;49604.50395496143;49706.75146624244;49736.00527989348;49844.50155498399;372156;459680.7015964899;461225;465278;513228;35509.934701958984;35979.920602380924;36252.27495450129;36258.81870590735;36294.54821807098;36529.452058218616;43557.56442435662;43793.46722864812;45054.54945450504;45439.545604543535;33096.50355244721;36389.454158187116;36416.45375319319;36489.63510364862;36549.81725091358;36112.63887361093;36129;37061.258774823815;37183.442248365754;37492.87521374363;35803.10492237715;35894.8205258972;36071.458928116626;36357;36989.26021479609;28962.972591918362;31278.687213127578;32365.67634323721;32570.83714581412;32802;20377.89811050935;23191.188308409124;24596.631050534615;24785.752142479065;25110.49779004446 03:23:10 INFO - PROCESS | 1959 | |2;jquery.html;416.40869964650193;426.8420684346792;435.55538194105355;435.97602131882746;440.29772512842004;18628.441146765603;19726.506837329056;20926.162953481842;20928.84891330976;21075.47311317218;20052.097655605496;20956.89521552394;21462.678059829075;21566.89216553915;22089.558208835813;6245.625262484255;6525.706343214567;6529.085927970088;6538.084668146464;6558.442532384753;6260.436560709535;6355.173827402431;6364.6181229126405;6491.870162596745;6502.902456463157;5501.312335958005;5621.606487545873;6423.021125221107;6490.188726409199;6492.220933487988;6285.497160227171;6421.8073457796345;6434.742610295582;6456.160699109133;6461.935380646204;6050.3647117052515;6234.345393733638;6291.182146320994;6321.589096708699;6340.461060809836;22015.669764953538;24559.50880982388;25591;25615.103471378414;25856.70716464188;3301.273719781644;3313.5526703894907;3343.8328083595966;3423.589169299675;3495.2135769451925;15174.834883674735;15577.90954633176;15700.92149539245;16172.919135404365;16579.005259684458;1996.5008747813047;2064.040221297104;2078.9272375466935;2083.364573804989;2083.635363811342;136130.3193484026;136339.31830340883;155609.66585501115;160921;161545;16852.073135977393;18714.532136696693;18753;20440.284590039573;20763.896180519;30228.09315720532;30258;30555.541666875015;30670.773169073433;30854.69145308563;9808.411495310304;9932.503374831374;10121.949390253149;10241.590336386462;10295.3822770634;8394.664213431395;8417.158284171657;8439.70461033861;8452.915470845213;8492.575371231538;9357.298202634693;9599.568019439143;9680.370775899544;9694.321397502248;9720.27097967641;3503.632118627558;4116.217918595457;4159.961618806763;4165;4202;1000.25980774228;1003.087190656499;1014.9492525373702;1017.1862509991977;1055.1506037639774;16557.751633725504;20723.585528289652;20930.581388372146;21024.369268921957;21111.26110586153;996.9850452243222;1002.8245057114975;1030.5105075089423;1030.907218350352;1034.0641719244097;10244.48777561119;10621;10719.785604288027;10741.624043158608;10746.24776265654;732919;744299;747901;752837;767717;96684;160787.37244196396;166273;167675.4848677271;168625;1316.3352506983913;1327.5353626230742;1370.5682709946136;1381;1384.4462215114036;19391.127399266785;19765.209391624176;20080.69878951846;20146.294879679142;20163.39509814708;66214;66352.33647663654;66394;67777;68512.6574367125;65645.67177164083;78415;87429.56285218534;96384.10847674581;98288.50855745962;13122.506723722463;13130.212187268795;13454.26001569923;13608.86391136076;13913.373898174405;14263.786043209153;14397.920155988133;14455.13269203851;14536.781948270573;14965.77551336709;9754.51227438611;11848.229865058744;11944;12242.387880605756;12255.080868935043;11854.703632408913;11993.160478766402;12175.878241217828;12185.329806860353;12191.207571507824;9212.170904618617;12081.456334464794;12164.635060948185;12382.133250672367;12490.06324525646;10703.518341674799;10783.838242426527;13199.934000329937;13352.933235333761;13526.59420217395;9742.31803773729;10624.972017291848;11950.402479875798;12251.448684809384;12293.75412491763 03:23:10 INFO - PROCESS | 1959 | |3;mootools.html;1518;1531.9234038298082;1533.5935976966107;1537.2390666620022;1560.6176486760742;10588.99999999999;10891.6732498025;11155.665330040092;11231.213815032941;11325.886741132597;11188.104951603873;11292.943535282333;11304.830427543573;11332.150088743356;11358.31850088993;2398.1726304424947;2436.4030812450887;2436.902523899042;2436.9390765230924;2450.705915290159;2329.3594261578032;2355.9882200588972;2373.0151986925493;2373.4185124644487;2374.905003799846;2386.4153282445827;2403.5793736096202;2411.6503107049466;2412.986545650822;2414.396400899775;2335.556244313575;2349.788519033287;2351.5884720173985;2355.5053438777877;2364.3498038039506;2343.589871772433;2360.3037104054347;2402.1712509184304;2404.89177986991;2404.9278521644205;9248.491332976684;10789.676309710721;10954.123670106372;10961.177911656578;10985.231033827635;5763.711814409305;5967.701614919237;6031.276246850362;6038.667873266969;6041.395860413967;3351.5140304655934;3623.981880090609;3727.012341729444;3748.887533374003;3792.639699228569;1131.5134492168365;1159.4029075026367;1197.161986609377;1262.7095767973326;1267.866873978228;13622.795658065137;13808.930955345259;14911.701765964728;15208.923955380264;15366.462173823862;4682;4748.3184270825495;4782.33047373368;4838.637102217348;4848;11745.88254117465;11891.167618266638;11900.940495297467;11902.285862848257;11903.226290291102;5260.632235618767;5740.56945729072;5913.793017244376;5987.5808693391045;6001.3098493672915;5270.1040823060175;5295.761690723926;5328.733563321818;5343.70609616467;5386.192071189353;3924.823382947717;3997.620226078518;4018.0356714388336;4049.372347286175;4079.8368065277054;938.8921073133768;1069.6684027951205;1070.6145787516489;1071.9410432426291;1088.8077555077177;936.8220038192721;945.3996712087874;951.7477868364889;964.9758756031156;1011.4437059617181;6433.871322573522;6479.157709497735;6500.967495162588;6695.531312808057;6706;977.506359288569;992.4442312305132;993.4536005197112;1016.5577973581516;1038.6520515627349;4235.237657221668;4259.446271984684;4286.357046442996;4378.16814805186;4404.823807047682;13304.866951330363;13686.04197706171;13729;13742.519011834738;13772.517961871286;13160.934195328962;13361.26513041792;13467.057305988486;13590.38843252056;13612.591622251348;8760.342974276828;9974.301798874154;10047.095761381364;10117.241206909512;10426.113780328757;6337.746490140343;6816.931830681828;6886.965565172142;6960.4779641526075;6979.825504362431;11759.706007349543;11864.940675296568;12022.819657704966;12090.939545302217;12133.878661213275;10131.746706332106;12021.45903434365;12176;12397.256164630151;12478.376081195722;7619.352355049883;8177.6320065596;8475.618597163266;8488.448250863674;8562.57187140628;9168.037356077783;10225.642102526375;10232.846507302247;10339.741506462398;10347.586096556053;8042.115367309474;8225.588720563828;8238.50568965864;8355.874661880198;8559.614817333111;7837.216278372117;9019.954900225457;9137.40606860552;9157.221636160735;9337;7826.373890088893;7858.292753652198;7922.445428820158;7960.601969901598;7990.840183196187;5834.795782147605;5839.474447299764;5857.707114644336;6002.609830361012;6084.969575152273;5888.705564721661;6002.909956350745;6027.849303767441;6115.84710382244;6163.673605015002 03:23:10 INFO - PROCESS | 1959 | |4;prototype.html;336.6246635001973;358.2619803205397;362.4816512387285;375.183974854691;391.50670155603933;4533.931991020129;5167.844964651057;5177.352830896138;5376.301080859487;5381.730913454327;4596.97701511492;4975.054809502646;5041.974790126053;5054.696718196901;5291.867703307419;4053.6351728344443;4610.838620648269;4647.443106559307;4648.349231107648;4657.51096134906;3811.9809400953095;4204.957950420502;4623.190941585226;4624.237000894848;4666.76666166692;3888.786116763577;4214.431051808013;4381.3208952612395;4587.311903214511;4587.449506059277;4156.521999969982;4409.5149533551285;4580.473245576768;4618.053299073682;4621.792019359137;3540.8760693375866;3695.6489133532273;3788.8295026723863;4409.228385032607;4413.602775750198;4606.631469482433;4664.580187783082;5054.978008796511;5152.871178220537;5197.948020519784;4533.9319910201375;4697.084068606623;5111.744412779346;5135.332406787131;5136.614753893436;5361;5780.046292361755;5786;5808.22465397495;5846.1353936571195;3763.4542991266385;4320.851982097159;4441.290103310216;4523.36672865799;4561.315802629599;5708.914366284509;5795.594828146314;5815.575184079885;5872.383399743051;6071.726772295213;3937.370020796659;4629.629629629621;4644.489106198315;4645.419322584677;4651.395318608627;4713.151632706077;4714.434267887876;4721.126591580569;4738.691985020962;4746.311784791186;4780.633586374697;5069.746512674352;5088.262201980692;5117.4391810498155;5167;5383.757730902119;5572.408829894119;5676.90608618304;5682.573806964494;5722;1465.7728052151933;1481;1517.8178618565844;1570.7879436275957;1630.4537979776671;1109.9001089901947;1177.464253764535;1210.6186551236333;1211.3943028485758;1216.3431746856775;4804.750764801107;4863.829765958175;5072.594192464594;5369.140927460654;5374.220737993047;5052.722100284446;5090.643654944192;5298.509700440786;5743.310802703702;5863.853403664943;4801.167311286358;4853.635977301717;5335.733213339317;5413.2692086568595;5430.619856610078;2933.3306690911168;3041.6654168041496;3063.177409441379;3083.5066389377594;3088.5521599368417;4937.432195297515;5832.8541786454825;5863.501602363847;5925.081612350093;6122.265328160649;4966.279889416087;5241.475852414805;6055.6063855849225;6065.909011364833;6103.877922441527;5433.157860531703;5854.507100689297;6073.210482637317;6152.3540028297275;6186.937465954381;4790.353302304284;4986.526280003394;5590.748416321357;5608.401605542401;5929.073051258272;5301.840944771663;5513.8345849624575;5805.767769289181;5814.592978491634;5851.483861939407;5501.771782428123;5513.862153446035;5888.381719919346;5967.31375891778;6104;3987.641112299791;4094.529129150186;4534.88895220673;4573.268277075652;4578.2903649934315;4897.8285759998225;4983.825566105169;5437.048516509674;5789.3921138279875;5854.4730974212525;4714.467797965744;5165.9483405165465;5205.323307970091;5490.011797876261;5639.436056394492;4952.455229924777;5627.396192085236;5647.265855438766;5654.427235607706;5680.517156041783;4986.276989836381;5151.609065552205;5302.151655735064;5316.192494551871;5474.5894057945015;4618.745968971739;5605.243292155506;5660.85847853807;5674.546036317167;5677.858053548694;4998.4251811042195;5362.436944120967;5489.780408783764;5530.364008139116;5548.500634942875 03:23:10 INFO - PROCESS | 1959 | |5;yui.html;715.7459102018787;717.4941666125383;765.3073968058909;826.884236206931;835.8579041562932;15160;15529.301181446834;16210.432634857752;16287.267072981715;16329.510114696563;15006.399744010254;15025.098494090334;15105.546833594983;15154.621134471616;15214.619634509143;896.7264984179823;905.6875377994597;938.7840796616748;942.0297093993164;943.47165587271;926.8934072581638;938.8403971324891;940.3652534539193;951.8667386565886;952.276270034775;952.7856232347701;987.9555420006081;989.7575094101919;992.5235886774352;994.4778991029694;964.8552717092457;969.7139343893568;980.1766516126488;980.9558569864338;982.0179820179784;714.5748279773527;731.6195578299307;731.7329174851194;732.1068296678044;733.3912852332551;16032.19839008045;16132.75800862988;16180.35278588855;16603.086830224333;16815.41146059882;14079.577612671636;14140.010199286055;14318.64203394913;14339.21134337611;14399.280035998157;11650.639752046418;11798.764024719458;11804.291742495392;11871.726178575705;11922.940385298018;3584.372734771405;3629.3104310181243;3657.8902632921054;3692.833822477995;3803.1633040730994;120325.99999999913;121261;125390;125660.37169814184;126766.3661681695;10495.632652857113;10590.413823739442;10939.12487001038;10952.726181845517;11062.778744425228;22465.32604021882;22708.65937010946;22712.886435567718;22744.31767046991;22793.88603056974;6504.804855854332;7854.8429031419055;7884.21157884207;7927.920720792834;7934.960325198337;3869.8645547406268;4276.5295817460055;4346.1525002624185;4347.9565204347555;4419.491758447755;2991.685872983349;3486.4944583035826;3546.929061418757;3585.94621080684;3586.9777113522523;564.4891373307164;643.2618323065848;650.0574167457206;656.2682608891148;661.9635920024349;663.1975309875008;685.2804555217002;686.7630667419733;696.2028477393458;713.9428845692332;9605.951970240105;10243.243511685298;10323.535440905178;10494.737631559272;10649.148068154529;668.759246671198;690.492488021304;706.6254884911006;720.5100531638432;721.90976127984;4856.635752318591;4957.925631115464;4992.600591952635;5003.574696150795;5029.220470827027;110270;110868.4456577712;112718;113657;114748;69301;83173;86008.13991860002;93095.67260818399;96348.55477167848;77545.61227193828;78213.21786782173;79388;80699.59650201829;81023;8889.288856891562;10014.59941602357;10406.895931040895;10639.14886809069;10642.787144256916;44865;47200;49198.50801491939;49860.501394985586;50259.74870125626;60539.57841686283;66956.330436695;67637.66181169063;67790.66104669445;68747;10844.024037836632;10853.674389768319;11035.668929932115;11758.412079396167;13600.97992650575;14565.781513277097;14643.48747793822;14889.776653349993;14948.701025979637;15130.848691513384;13531.526396576073;13553.051286410251;13749.968752343415;14170.574882753534;14491.347889344794;12787.872121278668;13517.729645407233;14218.786718199028;14253.28733563297;14932.328045238208;13343;13522;13793.172409655454;13961.301934903417;14346.49787257441;10959.671209863716;11175.273607215506;11258.831117533407;11291.811872635722;11453.885461145615;8312;10159.54282057324;10193.898061019296;11213.439328033728;11455.312681239153 03:23:10 INFO - PROCESS | 1959 | __end_tp_report 03:23:10 INFO - PROCESS | 1959 | __start_cc_report 03:23:10 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,417 03:23:10 INFO - PROCESS | 1959 | __end_cc_report 03:23:10 INFO - PROCESS | 1959 | __startTimestamp1489486990490__endTimestamp 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | ------- Summary: start ------- 03:23:10 INFO - PROCESS | 1959 | Number of tests: 6 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5980.27 Median:6225.19 stddev:655.14 (10.5%) stddev-sans-first:625.60 03:23:10 INFO - PROCESS | 1959 | Values: 3419.8 3432.3 3447.1 3464.6 3465.6 5925.3 6003.4 6044.8 6055.6 6057.7 6026.7 6075.2 6115.5 6117.8 6126.5 5370.2 5431.8 5445.2 5454.0 5527.6 5505.7 5508.1 5514.6 5528.4 5568.2 5259.4 5308.4 5392.3 5503.7 5520.1 5420.2 5453.5 5494.1 5522.1 5574.8 5315.9 5432.3 5436.6 5437.7 5463.8 5727.0 6079.9 6094.5 6147.4 6156.1 6281.2 6283.2 6317.8 6324.8 6344.9 6445.0 6446.0 6450.5 6455.7 6463.1 6187.9 6206.2 6218.9 6225.2 6232.3 6283.9 6324.8 6502.2 6531.1 6601.3 6310.2 6335.2 6354.3 6355.4 6368.6 6316.5 6418.9 6420.8 6428.1 6429.6 6250.1 6285.9 6369.4 6372.6 6380.4 6254.7 6259.1 6280.5 6319.0 6323.0 5055.8 5136.5 5186.4 5192.5 5208.1 4273.8 4278.3 4570.3 4591.0 4596.9 5943.7 6138.6 6210.6 6220.9 6223.3 6301.4 6303.9 6306.3 6324.1 6361.7 6158.1 6170.9 6198.4 6207.5 6219.2 5715.3 5736.3 5737.9 5746.0 5770.0 6332.5 6355.3 6534.3 6562.6 6696.8 6429.8 6433.1 6447.3 6461.2 6480.3 6624.6 6705.4 6728.3 6729.6 6747.7 6252.9 6269.2 6271.3 6284.6 6383.5 6320.8 6427.5 6455.7 6469.5 6492.2 6328.8 6329.7 6330.5 6330.9 6368.1 6149.8 6206.6 6252.7 6284.6 6332.8 6125.2 6152.0 6288.0 6301.7 6318.1 6317.9 6340.9 6344.1 6348.6 6350.0 6035.1 6043.4 6159.0 6192.7 6204.4 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:56429.70 Median:34714.39 stddev:114767.28 (330.6%) stddev-sans-first:115013.02 03:23:10 INFO - PROCESS | 1959 | Values: 724.8 746.2 833.5 953.1 959.4 38070.9 38878.0 40429.4 40470.4 40518.4 39235.4 39341.4 39379.2 39451.6 39543.6 7952.1 8101.0 10553.6 10879.4 11046.8 10756.8 10861.1 10870.6 10873.0 10884.3 10812.8 10874.8 10894.1 10907.0 10911.3 10852.5 10871.9 10878.6 10881.2 10896.6 10629.5 10690.5 10694.9 10716.2 10794.3 27876.4 34690.7 34738.1 34755.8 34783.8 3718.7 3790.8 3792.7 3795.8 3801.1 25114.1 25156.2 25246.1 25555.2 26383.2 2521.9 3106.1 3115.2 3132.2 3226.5 289048.0 332255.0 334368.0 341248.0 402776.0 41775.6 41878.8 42034.4 42158.4 42194.7 44798.0 44899.8 44902.8 44970.8 45066.3 13542.5 13626.7 13647.7 13648.0 13653.0 11626.5 11783.5 12049.1 12080.8 12089.0 9213.4 9864.8 10396.6 12122.0 12183.7 5060.7 5678.6 5766.3 5785.3 5796.9 1084.8 1103.3 1105.5 1110.9 1160.2 24089.2 27126.7 27616.2 29375.6 29469.6 873.7 934.0 1012.6 1081.9 1173.0 14518.9 15527.0 15635.3 15704.2 15889.5 482375.0 482477.6 485610.0 485984.0 486249.0 57353.7 57674.0 58090.0 58124.4 58294.5 1460.2 1473.7 1495.1 1500.2 1506.7 23197.3 28356.0 29518.0 29797.7 29935.9 49161.3 49604.5 49706.8 49736.0 49844.5 372156.0 459680.7 461225.0 465278.0 513228.0 35509.9 35979.9 36252.3 36258.8 36294.5 36529.5 43557.6 43793.5 45054.5 45439.5 33096.5 36389.5 36416.5 36489.6 36549.8 36112.6 36129.0 37061.3 37183.4 37492.9 35803.1 35894.8 36071.5 36357.0 36989.3 28963.0 31278.7 32365.7 32570.8 32802.0 20377.9 23191.2 24596.6 24785.8 25110.5 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:42940.80 Median:20943.74 stddev:124951.34 (596.6%) stddev-sans-first:125261.06 03:23:10 INFO - PROCESS | 1959 | Values: 416.4 426.8 435.6 436.0 440.3 18628.4 19726.5 20926.2 20928.8 21075.5 20052.1 20956.9 21462.7 21566.9 22089.6 6245.6 6525.7 6529.1 6538.1 6558.4 6260.4 6355.2 6364.6 6491.9 6502.9 5501.3 5621.6 6423.0 6490.2 6492.2 6285.5 6421.8 6434.7 6456.2 6461.9 6050.4 6234.3 6291.2 6321.6 6340.5 22015.7 24559.5 25591.0 25615.1 25856.7 3301.3 3313.6 3343.8 3423.6 3495.2 15174.8 15577.9 15700.9 16172.9 16579.0 1996.5 2064.0 2078.9 2083.4 2083.6 136130.3 136339.3 155609.7 160921.0 161545.0 16852.1 18714.5 18753.0 20440.3 20763.9 30228.1 30258.0 30555.5 30670.8 30854.7 9808.4 9932.5 10121.9 10241.6 10295.4 8394.7 8417.2 8439.7 8452.9 8492.6 9357.3 9599.6 9680.4 9694.3 9720.3 3503.6 4116.2 4160.0 4165.0 4202.0 1000.3 1003.1 1014.9 1017.2 1055.2 16557.8 20723.6 20930.6 21024.4 21111.3 997.0 1002.8 1030.5 1030.9 1034.1 10244.5 10621.0 10719.8 10741.6 10746.2 732919.0 744299.0 747901.0 752837.0 767717.0 96684.0 160787.4 166273.0 167675.5 168625.0 1316.3 1327.5 1370.6 1381.0 1384.4 19391.1 19765.2 20080.7 20146.3 20163.4 66214.0 66352.3 66394.0 67777.0 68512.7 65645.7 78415.0 87429.6 96384.1 98288.5 13122.5 13130.2 13454.3 13608.9 13913.4 14263.8 14397.9 14455.1 14536.8 14965.8 9754.5 11848.2 11944.0 12242.4 12255.1 11854.7 11993.2 12175.9 12185.3 12191.2 9212.2 12081.5 12164.6 12382.1 12490.1 10703.5 10783.8 13199.9 13352.9 13526.6 9742.3 10625.0 11950.4 12251.4 12293.8 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:6677.82 Median:2436.92 stddev:4110.77 (168.7%) stddev-sans-first:4104.01 03:23:10 INFO - PROCESS | 1959 | Values: 1518.0 1531.9 1533.6 1537.2 1560.6 10589.0 10891.7 11155.7 11231.2 11325.9 11188.1 11292.9 11304.8 11332.2 11358.3 2398.2 2436.4 2436.9 2436.9 2450.7 2329.4 2356.0 2373.0 2373.4 2374.9 2386.4 2403.6 2411.7 2413.0 2414.4 2335.6 2349.8 2351.6 2355.5 2364.3 2343.6 2360.3 2402.2 2404.9 2404.9 9248.5 10789.7 10954.1 10961.2 10985.2 5763.7 5967.7 6031.3 6038.7 6041.4 3351.5 3624.0 3727.0 3748.9 3792.6 1131.5 1159.4 1197.2 1262.7 1267.9 13622.8 13808.9 14911.7 15208.9 15366.5 4682.0 4748.3 4782.3 4838.6 4848.0 11745.9 11891.2 11900.9 11902.3 11903.2 5260.6 5740.6 5913.8 5987.6 6001.3 5270.1 5295.8 5328.7 5343.7 5386.2 3924.8 3997.6 4018.0 4049.4 4079.8 938.9 1069.7 1070.6 1071.9 1088.8 936.8 945.4 951.7 965.0 1011.4 6433.9 6479.2 6501.0 6695.5 6706.0 977.5 992.4 993.5 1016.6 1038.7 4235.2 4259.4 4286.4 4378.2 4404.8 13304.9 13686.0 13729.0 13742.5 13772.5 13160.9 13361.3 13467.1 13590.4 13612.6 8760.3 9974.3 10047.1 10117.2 10426.1 6337.7 6816.9 6887.0 6960.5 6979.8 11759.7 11864.9 12022.8 12090.9 12133.9 10131.7 12021.5 12176.0 12397.3 12478.4 7619.4 8177.6 8475.6 8488.4 8562.6 9168.0 10225.6 10232.8 10339.7 10347.6 8042.1 8225.6 8238.5 8355.9 8559.6 7837.2 9020.0 9137.4 9157.2 9337.0 7826.4 7858.3 7922.4 7960.6 7990.8 5834.8 5839.5 5857.7 6002.6 6085.0 5888.7 6002.9 6027.8 6115.8 6163.7 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:4722.63 Median:5054.84 stddev:1306.77 (25.9%) stddev-sans-first:1268.30 03:23:10 INFO - PROCESS | 1959 | Values: 336.6 358.3 362.5 375.2 391.5 4533.9 5167.8 5177.4 5376.3 5381.7 4597.0 4975.1 5042.0 5054.7 5291.9 4053.6 4610.8 4647.4 4648.3 4657.5 3812.0 4205.0 4623.2 4624.2 4666.8 3888.8 4214.4 4381.3 4587.3 4587.4 4156.5 4409.5 4580.5 4618.1 4621.8 3540.9 3695.6 3788.8 4409.2 4413.6 4606.6 4664.6 5055.0 5152.9 5197.9 4533.9 4697.1 5111.7 5135.3 5136.6 5361.0 5780.0 5786.0 5808.2 5846.1 3763.5 4320.9 4441.3 4523.4 4561.3 5708.9 5795.6 5815.6 5872.4 6071.7 3937.4 4629.6 4644.5 4645.4 4651.4 4713.2 4714.4 4721.1 4738.7 4746.3 4780.6 5069.7 5088.3 5117.4 5167.0 5383.8 5572.4 5676.9 5682.6 5722.0 1465.8 1481.0 1517.8 1570.8 1630.5 1109.9 1177.5 1210.6 1211.4 1216.3 4804.8 4863.8 5072.6 5369.1 5374.2 5052.7 5090.6 5298.5 5743.3 5863.9 4801.2 4853.6 5335.7 5413.3 5430.6 2933.3 3041.7 3063.2 3083.5 3088.6 4937.4 5832.9 5863.5 5925.1 6122.3 4966.3 5241.5 6055.6 6065.9 6103.9 5433.2 5854.5 6073.2 6152.4 6186.9 4790.4 4986.5 5590.7 5608.4 5929.1 5301.8 5513.8 5805.8 5814.6 5851.5 5501.8 5513.9 5888.4 5967.3 6104.0 3987.6 4094.5 4534.9 4573.3 4578.3 4897.8 4983.8 5437.0 5789.4 5854.5 4714.5 5165.9 5205.3 5490.0 5639.4 4952.5 5627.4 5647.3 5654.4 5680.5 4986.3 5151.6 5302.2 5316.2 5474.6 4618.7 5605.2 5660.9 5674.5 5677.9 4998.4 5362.4 5489.8 5530.4 5548.5 03:23:10 INFO - PROCESS | 1959 | 03:23:10 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:21224.77 Median:3585.16 stddev:31478.66 (878.0%) stddev-sans-first:31529.30 03:23:10 INFO - PROCESS | 1959 | Values: 715.7 717.5 765.3 826.9 835.9 15160.0 15529.3 16210.4 16287.3 16329.5 15006.4 15025.1 15105.5 15154.6 15214.6 896.7 905.7 938.8 942.0 943.5 926.9 938.8 940.4 951.9 952.3 952.8 988.0 989.8 992.5 994.5 964.9 969.7 980.2 981.0 982.0 714.6 731.6 731.7 732.1 733.4 16032.2 16132.8 16180.4 16603.1 16815.4 14079.6 14140.0 14318.6 14339.2 14399.3 11650.6 11798.8 11804.3 11871.7 11922.9 3584.4 3629.3 3657.9 3692.8 3803.2 120326.0 121261.0 125390.0 125660.4 126766.4 10495.6 10590.4 10939.1 10952.7 11062.8 22465.3 22708.7 22712.9 22744.3 22793.9 6504.8 7854.8 7884.2 7927.9 7935.0 3869.9 4276.5 4346.2 4348.0 4419.5 2991.7 3486.5 3546.9 3585.9 3587.0 564.5 643.3 650.1 656.3 662.0 663.2 685.3 686.8 696.2 713.9 9606.0 10243.2 10323.5 10494.7 10649.1 668.8 690.5 706.6 720.5 721.9 4856.6 4957.9 4992.6 5003.6 5029.2 110270.0 110868.4 112718.0 113657.0 114748.0 69301.0 83173.0 86008.1 93095.7 96348.6 77545.6 78213.2 79388.0 80699.6 81023.0 8889.3 10014.6 10406.9 10639.1 10642.8 44865.0 47200.0 49198.5 49860.5 50259.7 60539.6 66956.3 67637.7 67790.7 68747.0 10844.0 10853.7 11035.7 11758.4 13601.0 14565.8 14643.5 14889.8 14948.7 15130.8 13531.5 13553.1 13750.0 14170.6 14491.3 12787.9 13517.7 14218.8 14253.3 14932.3 13343.0 13522.0 13793.2 13961.3 14346.5 10959.7 11175.3 11258.8 11291.8 11453.9 8312.0 10159.5 10193.9 11213.4 11455.3 03:23:10 INFO - PROCESS | 1959 | -------- Summary: end -------- 03:23:10 INFO - PROCESS | 1959 | 03:23:11 INFO - TEST-INFO | 1959: exit 0 03:23:11 INFO - TEST-OK | dromaeo_css | took 1116996ms 03:23:11 INFO - TEST-START | kraken 03:23:11 INFO - operating with platform_type : mac_ 03:23:11 INFO - Initialising browser for kraken test... 03:23:11 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpw7mP4b/profile http://localhost:52908/getInfo.html) 03:23:13 INFO - PROCESS | 1965 | 2017-03-14 03:23:13.810 plugin-container[1966:17812] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4553, name = 'com.apple.tsm.portname' 03:23:13 INFO - PROCESS | 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:13 INFO - PROCESS | 1965 | 2017-03-14 03:23:13.815 plugin-container[1966:17812] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 03:23:13 INFO - PROCESS | 1965 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:13 INFO - PROCESS | 1965 | 2017-03-14 03:23:13.815 plugin-container[1966:17812] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:23:13 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 03:23:13 INFO - PROCESS | 1965 | colorDepth:24 03:23:13 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 03:23:13 INFO - PROCESS | 1965 | __metrics 03:23:13 ERROR - PROCESS | 1965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 03:23:14 INFO - TEST-INFO | 1965: exit 0 03:23:14 INFO - Browser initialized. 03:23:14 INFO - Running cycle 1/1 for kraken test... 03:23:14 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/tmpw7mP4b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:17 INFO - PROCESS | 1967 | 2017-03-14 03:23:17.079 plugin-container[1968:17938] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 03:23:17 INFO - PROCESS | 1967 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:17 INFO - PROCESS | 1967 | 2017-03-14 03:23:17.079 plugin-container[1968:17938] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:23:17 INFO - PROCESS | 1967 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:23:17 INFO - PROCESS | 1967 | 2017-03-14 03:23:17.079 plugin-container[1968:17938] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:23:26 INFO - PROCESS | 1967 | RSS: Main: 220913664 03:23:26 INFO - PROCESS | 1967 | 03:23:29 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:30 INFO - PROCESS | 1967 | RSS: Main: 235294720 03:23:30 INFO - PROCESS | 1967 | 03:23:33 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-dft) 03:23:33 INFO - PROCESS | 1967 | RSS: Main: 243482624 03:23:33 INFO - PROCESS | 1967 | 03:23:37 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-fft) 03:23:38 INFO - PROCESS | 1967 | RSS: Main: 247205888 03:23:38 INFO - PROCESS | 1967 | 03:23:40 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-oscillator) 03:23:40 INFO - PROCESS | 1967 | RSS: Main: 248614912 03:23:40 INFO - PROCESS | 1967 | 03:23:42 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:43 INFO - PROCESS | 1967 | RSS: Main: 248631296 03:23:43 INFO - PROCESS | 1967 | 03:23:46 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52908/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:47 INFO - PROCESS | 1967 | RSS: Main: 253022208 03:23:47 INFO - PROCESS | 1967 | 03:23:50 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52908/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:51 INFO - PROCESS | 1967 | RSS: Main: 252637184 03:23:51 INFO - PROCESS | 1967 | 03:23:54 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52908/tests/kraken/driver.html?testName=json-parse-financial) 03:23:54 INFO - PROCESS | 1967 | RSS: Main: 252522496 03:23:54 INFO - PROCESS | 1967 | 03:23:56 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:57 INFO - PROCESS | 1967 | RSS: Main: 252231680 03:23:57 INFO - PROCESS | 1967 | 03:23:59 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:59 INFO - PROCESS | 1967 | RSS: Main: 252227584 03:23:59 INFO - PROCESS | 1967 | 03:24:01 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:02 INFO - PROCESS | 1967 | RSS: Main: 252784640 03:24:02 INFO - PROCESS | 1967 | 03:24:05 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:06 INFO - PROCESS | 1967 | RSS: Main: 252571648 03:24:06 INFO - PROCESS | 1967 | 03:24:09 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:09 INFO - PROCESS | 1967 | RSS: Main: 252448768 03:24:09 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52908/tests/kraken/driver.html?testName=ai-astar) 03:24:11 INFO - PROCESS | 1967 | RSS: Main: 254627840 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | __start_tp_report 03:24:11 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 03:24:11 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 03:24:11 INFO - PROCESS | 1967 | |i|pagename|runs| 03:24:11 INFO - PROCESS | 1967 | |0;ai-astar;116;173;164;122;118;118;119;134;119;119 03:24:11 INFO - PROCESS | 1967 | |1;audio-beat-detection;142;111;116;174;115;114;130;112;121;108 03:24:11 INFO - PROCESS | 1967 | |2;audio-dft;198;262;272;207;197;198;192;195;191;195 03:24:11 INFO - PROCESS | 1967 | |3;audio-fft;84;79;76;105;85;83;63;61;74;59 03:24:11 INFO - PROCESS | 1967 | |4;audio-oscillator;92;69;86;79;85;58;108;101;97;115 03:24:11 INFO - PROCESS | 1967 | |5;imaging-gaussian-blur;118;126;88;84;91;137;136;105;88;87 03:24:11 INFO - PROCESS | 1967 | |6;imaging-darkroom;124;96;111;154;98;119;107;148;140;95 03:24:11 INFO - PROCESS | 1967 | |7;imaging-desaturate;92;91;91;91;105;121;93;91;92;95 03:24:11 INFO - PROCESS | 1967 | |8;json-parse-financial;69;67;67;67;70;70;69;80;91;97 03:24:11 INFO - PROCESS | 1967 | |9;json-stringify-tinderbox;58;63;59;66;67;63;56;57;58;58 03:24:11 INFO - PROCESS | 1967 | |10;stanford-crypto-aes;86;89;87;88;86;82;85;86;90;87 03:24:11 INFO - PROCESS | 1967 | |11;stanford-crypto-ccm;149;151;131;139;138;149;158;167;197;170 03:24:11 INFO - PROCESS | 1967 | |12;stanford-crypto-pbkdf2;170;170;172;199;151;187;149;212;228;205 03:24:11 INFO - PROCESS | 1967 | |13;stanford-crypto-sha256-iterative;66;66;67;67;68;66;64;64;65;65 03:24:11 INFO - PROCESS | 1967 | __end_tp_report 03:24:11 INFO - PROCESS | 1967 | __start_cc_report 03:24:11 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1002 03:24:11 INFO - PROCESS | 1967 | __end_cc_report 03:24:11 INFO - PROCESS | 1967 | __startTimestamp1489487051876__endTimestamp 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | ------- Summary: start ------- 03:24:11 INFO - PROCESS | 1967 | Number of tests: 14 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#0] ai-astar Cycles:10 Average:130.20 Median:120.50 stddev:20.90 (17.3%) stddev-sans-first:21.53 03:24:11 INFO - PROCESS | 1967 | Values: 116.0 173.0 164.0 122.0 118.0 118.0 119.0 134.0 119.0 119.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:118.50 stddev:20.23 (17.1%) stddev-sans-first:20.41 03:24:11 INFO - PROCESS | 1967 | Values: 142.0 111.0 116.0 174.0 115.0 114.0 130.0 112.0 121.0 108.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#2] audio-dft Cycles:10 Average:210.70 Median:198.00 stddev:30.08 (15.2%) stddev-sans-first:31.55 03:24:11 INFO - PROCESS | 1967 | Values: 198.0 262.0 272.0 207.0 197.0 198.0 192.0 195.0 191.0 195.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#3] audio-fft Cycles:10 Average:76.90 Median:77.50 stddev:13.84 (17.9%) stddev-sans-first:14.43 03:24:11 INFO - PROCESS | 1967 | Values: 84.0 79.0 76.0 105.0 85.0 83.0 63.0 61.0 74.0 59.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:17.45 (21.3%) stddev-sans-first:18.47 03:24:11 INFO - PROCESS | 1967 | Values: 92.0 69.0 86.0 79.0 85.0 58.0 108.0 101.0 97.0 115.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#5] imaging-gaussian-blur Cycles:10 Average:106.00 Median:85.50 stddev:21.41 (25.0%) stddev-sans-first:22.26 03:24:11 INFO - PROCESS | 1967 | Values: 118.0 126.0 88.0 84.0 91.0 137.0 136.0 105.0 88.0 87.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#6] imaging-darkroom Cycles:10 Average:119.20 Median:151.00 stddev:21.82 (14.5%) stddev-sans-first:23.08 03:24:11 INFO - PROCESS | 1967 | Values: 124.0 96.0 111.0 154.0 98.0 119.0 107.0 148.0 140.0 95.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:91.50 stddev:9.70 (10.6%) stddev-sans-first:10.17 03:24:11 INFO - PROCESS | 1967 | Values: 92.0 91.0 91.0 91.0 105.0 121.0 93.0 91.0 92.0 95.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#8] json-parse-financial Cycles:10 Average:74.70 Median:70.00 stddev:10.94 (15.6%) stddev-sans-first:11.41 03:24:11 INFO - PROCESS | 1967 | Values: 69.0 67.0 67.0 67.0 70.0 70.0 69.0 80.0 91.0 97.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:3.92 (6.4%) stddev-sans-first:4.06 03:24:11 INFO - PROCESS | 1967 | Values: 58.0 63.0 59.0 66.0 67.0 63.0 56.0 57.0 58.0 58.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:2.22 (2.6%) stddev-sans-first:2.35 03:24:11 INFO - PROCESS | 1967 | Values: 86.0 89.0 87.0 88.0 86.0 82.0 85.0 86.0 90.0 87.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#11] stanford-crypto-ccm Cycles:10 Average:154.90 Median:154.50 stddev:19.30 (12.5%) stddev-sans-first:20.35 03:24:11 INFO - PROCESS | 1967 | Values: 149.0 151.0 131.0 139.0 138.0 149.0 158.0 167.0 197.0 170.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:193.00 stddev:26.34 (13.6%) stddev-sans-first:27.42 03:24:11 INFO - PROCESS | 1967 | Values: 170.0 170.0 172.0 199.0 151.0 187.0 149.0 212.0 228.0 205.0 03:24:11 INFO - PROCESS | 1967 | 03:24:11 INFO - PROCESS | 1967 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 03:24:11 INFO - PROCESS | 1967 | Values: 66.0 66.0 67.0 67.0 68.0 66.0 64.0 64.0 65.0 65.0 03:24:11 INFO - PROCESS | 1967 | -------- Summary: end -------- 03:24:11 INFO - PROCESS | 1967 | 03:24:12 INFO - TEST-INFO | 1967: exit 0 03:24:12 INFO - TEST-OK | kraken | took 61627ms 03:24:12 INFO - SUITE-END | took 1178s 03:24:13 INFO - Completed test suite (00:19:38) 03:24:13 INFO - javascript benchmark 03:24:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7787.155986870314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.7948123112606, 3432.330695514374, 3447.1037530242147, 3464.61889192189, 3465.5668041494814, 5925.288965324162, 6003.429674180951, 6044.758209671619, 6055.60638558494, 6057.727402266897, 6026.6685332306815, 6075.2405949256345, 6115.48018418435, 6117.755289788403, 6126.509879209663, 5370.248165256867, 5431.83704488864, 5445.237666726642, 5454.0, 5527.640703354289, 5505.6696598204035, 5508.091164957777, 5514.6139770216105, 5528.44715528448, 5568.248286481314, 5259.3951695555115, 5308.416074231832, 5392.325959255093, 5503.724813759296, 5520.1443776214755, 5420.186971954199, 5453.454654534555, 5494.120940649517, 5522.144067669517, 5574.777008919638, 5315.893682126336, 5432.320959880015, 5436.646617969819, 5437.700926449043, 5463.7814487420455, 5726.9713651431475, 6079.878402431971, 6094.512439004913, 6147.354527774609, 6156.076588511714, 6281.152044473984, 6283.214598175228, 6317.842053948642, 6324.841878953017, 6344.904826427607, 6445.001024841157, 6446.033095035736, 6450.451711604519, 6455.709493072823, 6463.06285588587, 6187.907181392283, 6206.193194884681, 6218.937810621881, 6225.190725205694, 6232.3144454110015, 6283.937160628335, 6324.841878953063, 6502.2197336318995, 6531.0856480092825, 6601.2738598754095, 6310.211223597051, 6335.208098987627, 6354.332795056453, 6355.396237357444, 6368.617882927039, 6316.526260530479, 6418.8716225675225, 6420.839479012969, 6428.100065990765, 6429.646369449725, 6250.093736408196, 6285.8742825143245, 6369.394907483782, 6372.6495042773095, 6380.361963803675, 6254.655993920378, 6259.123722678829, 6280.466160376419, 6319.0, 6322.968385158045, 5055.823046193365, 5136.460671629425, 5186.429492755794, 5192.4807519248525, 5208.088584497697, 4273.764942928106, 4278.315469524923, 4570.268756998864, 4591.0, 4596.931046034312, 5943.673097979567, 6138.631682099089, 6210.565260431817, 6220.875582488416, 6223.315435302113, 6301.40136687014, 6303.905441418382, 6306.2747784004505, 6324.051392291101, 6361.745530178741, 6158.107074474266, 6170.876582468325, 6198.411150940653, 6207.472364848948, 6219.160413344141, 5715.2855893013375, 5736.340320863071, 5737.913931291034, 5745.999999999916, 5770.0, 6332.461740752087, 6355.269144048493, 6534.281229064704, 6562.573432726857, 6696.7656132035145, 6429.839254018687, 6433.099366088845, 6447.323031081669, 6461.224653041665, 6480.287168411565, 6624.56940298879, 6705.396514313735, 6728.3271672832325, 6729.5625784323865, 6747.730090796509, 6252.9062064069985, 6269.216347956505, 6271.310155882758, 6284.591501552384, 6383.457406120346, 6320.810375688737, 6427.485801135991, 6455.677216139268, 6469.547131700736, 6492.220933488012, 6328.841778955563, 6329.6518691470565, 6330.525210609315, 6330.936690633035, 6368.108464814837, 6149.7847575334645, 6206.627602343874, 6252.749890004349, 6284.622922624657, 6332.810015699536, 6125.203723516092, 6152.0, 6288.0, 6301.684915754286, 6318.052292156213, 6317.905231421624, 6340.922043252566, 6344.111824344688, 6348.587341822767, 6349.984002559569, 6035.064564992434, 6043.395660433922, 6159.0, 6192.690365481798, 6204.410580994799], "value": 5937.067591153658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.8151721311067, 746.1941103608103, 833.4874052457739, 953.0802775321813, 959.4291396619009, 38070.857874263784, 38878.0, 40429.393559096636, 40470.392944105864, 40518.39222411666, 39235.41146882799, 39341.409878851766, 39379.21241575167, 39451.60548394515, 39543.604563954425, 7952.085510166333, 8100.959495202515, 10553.577856885715, 10879.401632910187, 11046.779064418706, 10756.838647420294, 10861.076808471289, 10870.565177392895, 10873.0, 10884.292520986111, 10812.837807432894, 10874.836877446845, 10894.128469722444, 10907.0, 10911.345319280828, 10852.511636976355, 10871.945640271828, 10878.619248326271, 10881.238313318032, 10896.564137434492, 10629.5216715248, 10690.51892664832, 10694.946525267402, 10716.249862509627, 10794.298370605886, 27876.44247115046, 34690.653093468994, 34738.131546711535, 34755.826220868985, 34783.82608086969, 3718.7396882218254, 3790.7725536467624, 3792.7345085844004, 3795.8291876865333, 3801.1067399161175, 25114.12100576471, 25156.24531264065, 25246.116385926587, 25555.211135220543, 26383.229760875023, 2521.8612976286295, 3106.1147572941827, 3115.2056225662536, 3132.2482604174834, 3226.451503244454, 289048.0, 332254.99999999756, 334368.0, 341248.0, 402775.98612007045, 41775.58224417717, 41878.79060604677, 42034.369484457755, 42158.367624485654, 42194.73415797531, 44798.0, 44899.77550112294, 44902.77548612301, 44970.75146242675, 45066.32400513995, 13542.45830166802, 13626.659333516742, 13647.727045459034, 13648.0, 13653.0, 11626.53493860253, 11783.469743861548, 12049.096317776202, 12080.818787718192, 12089.0, 9213.447193168431, 9864.802703945881, 10396.636117735843, 12122.030237580972, 12183.695407614881, 5060.671056381397, 5678.5741069419955, 5766.34748015909, 5785.27684039495, 5796.913046304308, 1084.7830433913248, 1103.3104309806372, 1105.5467258424007, 1110.9277896936674, 1160.1762748448527, 24089.156879509133, 27126.74821691823, 27616.171514854588, 29375.55936660952, 29469.55795663024, 873.6767396063498, 933.9533023348805, 1012.5747186181674, 1081.9404932728619, 1172.976540469186, 14518.896083934063, 15526.990745601499, 15635.296411661502, 15704.214789260719, 15889.52331430059, 482375.0, 482477.58761205967, 485610.0, 485984.0, 486249.0, 57353.71323143441, 57674.0, 58090.0, 58124.4187558119, 58294.54263643358, 1460.1531111955042, 1473.734727748994, 1495.1477657735204, 1500.2423775993054, 1506.6760646461064, 23197.304080877602, 28356.0, 29517.966871159406, 29797.702022979494, 29935.850320749127, 49161.2625810606, 49604.50395496143, 49706.75146624244, 49736.00527989348, 49844.50155498399, 372156.0, 459680.7015964899, 461225.0, 465278.0, 513228.0, 35509.934701958984, 35979.920602380924, 36252.27495450129, 36258.81870590735, 36294.54821807098, 36529.452058218616, 43557.56442435662, 43793.46722864812, 45054.54945450504, 45439.545604543535, 33096.50355244721, 36389.454158187116, 36416.45375319319, 36489.63510364862, 36549.81725091358, 36112.63887361093, 36129.0, 37061.258774823815, 37183.442248365754, 37492.87521374363, 35803.10492237715, 35894.8205258972, 36071.458928116626, 36357.0, 36989.26021479609, 28962.972591918362, 31278.687213127578, 32365.67634323721, 32570.83714581412, 32802.0, 20377.89811050935, 23191.188308409124, 24596.631050534615, 24785.752142479065, 25110.49779004446], "value": 18810.840563977657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.40869964650193, 426.8420684346792, 435.55538194105355, 435.97602131882746, 440.29772512842004, 18628.441146765603, 19726.506837329056, 20926.162953481842, 20928.84891330976, 21075.47311317218, 20052.097655605496, 20956.89521552394, 21462.678059829075, 21566.89216553915, 22089.558208835813, 6245.625262484255, 6525.706343214567, 6529.085927970088, 6538.084668146464, 6558.442532384753, 6260.436560709535, 6355.173827402431, 6364.6181229126405, 6491.870162596745, 6502.902456463157, 5501.312335958005, 5621.606487545873, 6423.021125221107, 6490.188726409199, 6492.220933487988, 6285.497160227171, 6421.8073457796345, 6434.742610295582, 6456.160699109133, 6461.935380646204, 6050.3647117052515, 6234.345393733638, 6291.182146320994, 6321.589096708699, 6340.461060809836, 22015.669764953538, 24559.50880982388, 25591.0, 25615.103471378414, 25856.70716464188, 3301.273719781644, 3313.5526703894907, 3343.8328083595966, 3423.589169299675, 3495.2135769451925, 15174.834883674735, 15577.90954633176, 15700.92149539245, 16172.919135404365, 16579.005259684458, 1996.5008747813047, 2064.040221297104, 2078.9272375466935, 2083.364573804989, 2083.635363811342, 136130.3193484026, 136339.31830340883, 155609.66585501115, 160921.0, 161545.0, 16852.073135977393, 18714.532136696693, 18753.0, 20440.284590039573, 20763.896180519, 30228.09315720532, 30258.0, 30555.541666875015, 30670.773169073433, 30854.69145308563, 9808.411495310304, 9932.503374831374, 10121.949390253149, 10241.590336386462, 10295.3822770634, 8394.664213431395, 8417.158284171657, 8439.70461033861, 8452.915470845213, 8492.575371231538, 9357.298202634693, 9599.568019439143, 9680.370775899544, 9694.321397502248, 9720.27097967641, 3503.632118627558, 4116.217918595457, 4159.961618806763, 4165.0, 4202.0, 1000.25980774228, 1003.087190656499, 1014.9492525373702, 1017.1862509991977, 1055.1506037639774, 16557.751633725504, 20723.585528289652, 20930.581388372146, 21024.369268921957, 21111.26110586153, 996.9850452243222, 1002.8245057114975, 1030.5105075089423, 1030.907218350352, 1034.0641719244097, 10244.48777561119, 10621.0, 10719.785604288027, 10741.624043158608, 10746.24776265654, 732919.0, 744299.0, 747901.0, 752837.0, 767717.0, 96684.0, 160787.37244196396, 166273.0, 167675.4848677271, 168625.0, 1316.3352506983913, 1327.5353626230742, 1370.5682709946136, 1381.0, 1384.4462215114036, 19391.127399266785, 19765.209391624176, 20080.69878951846, 20146.294879679142, 20163.39509814708, 66214.0, 66352.33647663654, 66394.0, 67777.0, 68512.6574367125, 65645.67177164083, 78415.0, 87429.56285218534, 96384.10847674581, 98288.50855745962, 13122.506723722463, 13130.212187268795, 13454.26001569923, 13608.86391136076, 13913.373898174405, 14263.786043209153, 14397.920155988133, 14455.13269203851, 14536.781948270573, 14965.77551336709, 9754.51227438611, 11848.229865058744, 11944.0, 12242.387880605756, 12255.080868935043, 11854.703632408913, 11993.160478766402, 12175.878241217828, 12185.329806860353, 12191.207571507824, 9212.170904618617, 12081.456334464794, 12164.635060948185, 12382.133250672367, 12490.06324525646, 10703.518341674799, 10783.838242426527, 13199.934000329937, 13352.933235333761, 13526.59420217395, 9742.31803773729, 10624.972017291848, 11950.402479875798, 12251.448684809384, 12293.75412491763], "value": 11667.419993865167, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.0, 1531.9234038298082, 1533.5935976966107, 1537.2390666620022, 1560.6176486760742, 10588.99999999999, 10891.6732498025, 11155.665330040092, 11231.213815032941, 11325.886741132597, 11188.104951603873, 11292.943535282333, 11304.830427543573, 11332.150088743356, 11358.31850088993, 2398.1726304424947, 2436.4030812450887, 2436.902523899042, 2436.9390765230924, 2450.705915290159, 2329.3594261578032, 2355.9882200588972, 2373.0151986925493, 2373.4185124644487, 2374.905003799846, 2386.4153282445827, 2403.5793736096202, 2411.6503107049466, 2412.986545650822, 2414.396400899775, 2335.556244313575, 2349.788519033287, 2351.5884720173985, 2355.5053438777877, 2364.3498038039506, 2343.589871772433, 2360.3037104054347, 2402.1712509184304, 2404.89177986991, 2404.9278521644205, 9248.491332976684, 10789.676309710721, 10954.123670106372, 10961.177911656578, 10985.231033827635, 5763.711814409305, 5967.701614919237, 6031.276246850362, 6038.667873266969, 6041.395860413967, 3351.5140304655934, 3623.981880090609, 3727.012341729444, 3748.887533374003, 3792.639699228569, 1131.5134492168365, 1159.4029075026367, 1197.161986609377, 1262.7095767973326, 1267.866873978228, 13622.795658065137, 13808.930955345259, 14911.701765964728, 15208.923955380264, 15366.462173823862, 4682.0, 4748.3184270825495, 4782.33047373368, 4838.637102217348, 4848.0, 11745.88254117465, 11891.167618266638, 11900.940495297467, 11902.285862848257, 11903.226290291102, 5260.632235618767, 5740.56945729072, 5913.793017244376, 5987.5808693391045, 6001.3098493672915, 5270.1040823060175, 5295.761690723926, 5328.733563321818, 5343.70609616467, 5386.192071189353, 3924.823382947717, 3997.620226078518, 4018.0356714388336, 4049.372347286175, 4079.8368065277054, 938.8921073133768, 1069.6684027951205, 1070.6145787516489, 1071.9410432426291, 1088.8077555077177, 936.8220038192721, 945.3996712087874, 951.7477868364889, 964.9758756031156, 1011.4437059617181, 6433.871322573522, 6479.157709497735, 6500.967495162588, 6695.531312808057, 6706.0, 977.506359288569, 992.4442312305132, 993.4536005197112, 1016.5577973581516, 1038.6520515627349, 4235.237657221668, 4259.446271984684, 4286.357046442996, 4378.16814805186, 4404.823807047682, 13304.866951330363, 13686.04197706171, 13729.0, 13742.519011834738, 13772.517961871286, 13160.934195328962, 13361.26513041792, 13467.057305988486, 13590.38843252056, 13612.591622251348, 8760.342974276828, 9974.301798874154, 10047.095761381364, 10117.241206909512, 10426.113780328757, 6337.746490140343, 6816.931830681828, 6886.965565172142, 6960.4779641526075, 6979.825504362431, 11759.706007349543, 11864.940675296568, 12022.819657704966, 12090.939545302217, 12133.878661213275, 10131.746706332106, 12021.45903434365, 12176.0, 12397.256164630151, 12478.376081195722, 7619.352355049883, 8177.6320065596, 8475.618597163266, 8488.448250863674, 8562.57187140628, 9168.037356077783, 10225.642102526375, 10232.846507302247, 10339.741506462398, 10347.586096556053, 8042.115367309474, 8225.588720563828, 8238.50568965864, 8355.874661880198, 8559.614817333111, 7837.216278372117, 9019.954900225457, 9137.40606860552, 9157.221636160735, 9337.0, 7826.373890088893, 7858.292753652198, 7922.445428820158, 7960.601969901598, 7990.840183196187, 5834.795782147605, 5839.474447299764, 5857.707114644336, 6002.609830361012, 6084.969575152273, 5888.705564721661, 6002.909956350745, 6027.849303767441, 6115.84710382244, 6163.673605015002], "value": 5129.664073389081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6246635001973, 358.2619803205397, 362.4816512387285, 375.183974854691, 391.50670155603933, 4533.931991020129, 5167.844964651057, 5177.352830896138, 5376.301080859487, 5381.730913454327, 4596.97701511492, 4975.054809502646, 5041.974790126053, 5054.696718196901, 5291.867703307419, 4053.6351728344443, 4610.838620648269, 4647.443106559307, 4648.349231107648, 4657.51096134906, 3811.9809400953095, 4204.957950420502, 4623.190941585226, 4624.237000894848, 4666.76666166692, 3888.786116763577, 4214.431051808013, 4381.3208952612395, 4587.311903214511, 4587.449506059277, 4156.521999969982, 4409.5149533551285, 4580.473245576768, 4618.053299073682, 4621.792019359137, 3540.8760693375866, 3695.6489133532273, 3788.8295026723863, 4409.228385032607, 4413.602775750198, 4606.631469482433, 4664.580187783082, 5054.978008796511, 5152.871178220537, 5197.948020519784, 4533.9319910201375, 4697.084068606623, 5111.744412779346, 5135.332406787131, 5136.614753893436, 5361.0, 5780.046292361755, 5786.0, 5808.22465397495, 5846.1353936571195, 3763.4542991266385, 4320.851982097159, 4441.290103310216, 4523.36672865799, 4561.315802629599, 5708.914366284509, 5795.594828146314, 5815.575184079885, 5872.383399743051, 6071.726772295213, 3937.370020796659, 4629.629629629621, 4644.489106198315, 4645.419322584677, 4651.395318608627, 4713.151632706077, 4714.434267887876, 4721.126591580569, 4738.691985020962, 4746.311784791186, 4780.633586374697, 5069.746512674352, 5088.262201980692, 5117.4391810498155, 5167.0, 5383.757730902119, 5572.408829894119, 5676.90608618304, 5682.573806964494, 5722.0, 1465.7728052151933, 1481.0, 1517.8178618565844, 1570.7879436275957, 1630.4537979776671, 1109.9001089901947, 1177.464253764535, 1210.6186551236333, 1211.3943028485758, 1216.3431746856775, 4804.750764801107, 4863.829765958175, 5072.594192464594, 5369.140927460654, 5374.220737993047, 5052.722100284446, 5090.643654944192, 5298.509700440786, 5743.310802703702, 5863.853403664943, 4801.167311286358, 4853.635977301717, 5335.733213339317, 5413.2692086568595, 5430.619856610078, 2933.3306690911168, 3041.6654168041496, 3063.177409441379, 3083.5066389377594, 3088.5521599368417, 4937.432195297515, 5832.8541786454825, 5863.501602363847, 5925.081612350093, 6122.265328160649, 4966.279889416087, 5241.475852414805, 6055.6063855849225, 6065.909011364833, 6103.877922441527, 5433.157860531703, 5854.507100689297, 6073.210482637317, 6152.3540028297275, 6186.937465954381, 4790.353302304284, 4986.526280003394, 5590.748416321357, 5608.401605542401, 5929.073051258272, 5301.840944771663, 5513.8345849624575, 5805.767769289181, 5814.592978491634, 5851.483861939407, 5501.771782428123, 5513.862153446035, 5888.381719919346, 5967.31375891778, 6104.0, 3987.641112299791, 4094.529129150186, 4534.88895220673, 4573.268277075652, 4578.2903649934315, 4897.8285759998225, 4983.825566105169, 5437.048516509674, 5789.3921138279875, 5854.4730974212525, 4714.467797965744, 5165.9483405165465, 5205.323307970091, 5490.011797876261, 5639.436056394492, 4952.455229924777, 5627.396192085236, 5647.265855438766, 5654.427235607706, 5680.517156041783, 4986.276989836381, 5151.609065552205, 5302.151655735064, 5316.192494551871, 5474.5894057945015, 4618.745968971739, 5605.243292155506, 5660.85847853807, 5674.546036317167, 5677.858053548694, 4998.4251811042195, 5362.436944120967, 5489.780408783764, 5530.364008139116, 5548.500634942875], "value": 4334.433839072276, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.7459102018787, 717.4941666125383, 765.3073968058909, 826.884236206931, 835.8579041562932, 15160.0, 15529.301181446834, 16210.432634857752, 16287.267072981715, 16329.510114696563, 15006.399744010254, 15025.098494090334, 15105.546833594983, 15154.621134471616, 15214.619634509143, 896.7264984179823, 905.6875377994597, 938.7840796616748, 942.0297093993164, 943.47165587271, 926.8934072581638, 938.8403971324891, 940.3652534539193, 951.8667386565886, 952.276270034775, 952.7856232347701, 987.9555420006081, 989.7575094101919, 992.5235886774352, 994.4778991029694, 964.8552717092457, 969.7139343893568, 980.1766516126488, 980.9558569864338, 982.0179820179784, 714.5748279773527, 731.6195578299307, 731.7329174851194, 732.1068296678044, 733.3912852332551, 16032.19839008045, 16132.75800862988, 16180.35278588855, 16603.086830224333, 16815.41146059882, 14079.577612671636, 14140.010199286055, 14318.64203394913, 14339.21134337611, 14399.280035998157, 11650.639752046418, 11798.764024719458, 11804.291742495392, 11871.726178575705, 11922.940385298018, 3584.372734771405, 3629.3104310181243, 3657.8902632921054, 3692.833822477995, 3803.1633040730994, 120325.99999999913, 121261.0, 125390.0, 125660.37169814184, 126766.3661681695, 10495.632652857113, 10590.413823739442, 10939.12487001038, 10952.726181845517, 11062.778744425228, 22465.32604021882, 22708.65937010946, 22712.886435567718, 22744.31767046991, 22793.88603056974, 6504.804855854332, 7854.8429031419055, 7884.21157884207, 7927.920720792834, 7934.960325198337, 3869.8645547406268, 4276.5295817460055, 4346.1525002624185, 4347.9565204347555, 4419.491758447755, 2991.685872983349, 3486.4944583035826, 3546.929061418757, 3585.94621080684, 3586.9777113522523, 564.4891373307164, 643.2618323065848, 650.0574167457206, 656.2682608891148, 661.9635920024349, 663.1975309875008, 685.2804555217002, 686.7630667419733, 696.2028477393458, 713.9428845692332, 9605.951970240105, 10243.243511685298, 10323.535440905178, 10494.737631559272, 10649.148068154529, 668.759246671198, 690.492488021304, 706.6254884911006, 720.5100531638432, 721.90976127984, 4856.635752318591, 4957.925631115464, 4992.600591952635, 5003.574696150795, 5029.220470827027, 110270.0, 110868.4456577712, 112718.0, 113657.0, 114748.0, 69301.0, 83173.0, 86008.13991860002, 93095.67260818399, 96348.55477167848, 77545.61227193828, 78213.21786782173, 79388.0, 80699.59650201829, 81023.0, 8889.288856891562, 10014.59941602357, 10406.895931040895, 10639.14886809069, 10642.787144256916, 44865.0, 47200.0, 49198.50801491939, 49860.501394985586, 50259.74870125626, 60539.57841686283, 66956.330436695, 67637.66181169063, 67790.66104669445, 68747.0, 10844.024037836632, 10853.674389768319, 11035.668929932115, 11758.412079396167, 13600.97992650575, 14565.781513277097, 14643.48747793822, 14889.776653349993, 14948.701025979637, 15130.848691513384, 13531.526396576073, 13553.051286410251, 13749.968752343415, 14170.574882753534, 14491.347889344794, 12787.872121278668, 13517.729645407233, 14218.786718199028, 14253.28733563297, 14932.328045238208, 13343.0, 13522.0, 13793.172409655454, 13961.301934903417, 14346.49787257441, 10959.671209863716, 11175.273607215506, 11258.831117533407, 11291.811872635722, 11453.885461145615, 8312.0, 10159.54282057324, 10193.898061019296, 11213.439328033728, 11455.312681239153], "value": 7695.853590682162, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 173.0, 164.0, 122.0, 118.0, 118.0, 119.0, 134.0, 119.0, 119.0], "value": 130.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 116.0, 174.0, 115.0, 114.0, 130.0, 112.0, 121.0, 108.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 262.0, 272.0, 207.0, 197.0, 198.0, 192.0, 195.0, 191.0, 195.0], "value": 210.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 76.0, 105.0, 85.0, 83.0, 63.0, 61.0, 74.0, 59.0], "value": 76.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 86.0, 79.0, 85.0, 58.0, 108.0, 101.0, 97.0, 115.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 126.0, 88.0, 84.0, 91.0, 137.0, 136.0, 105.0, 88.0, 87.0], "value": 106.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 96.0, 111.0, 154.0, 98.0, 119.0, 107.0, 148.0, 140.0, 95.0], "value": 119.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 91.0, 105.0, 121.0, 93.0, 91.0, 92.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 70.0, 70.0, 69.0, 80.0, 91.0, 97.0], "value": 74.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 59.0, 66.0, 67.0, 63.0, 56.0, 57.0, 58.0, 58.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 87.0, 88.0, 86.0, 82.0, 85.0, 86.0, 90.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 131.0, 139.0, 138.0, 149.0, 158.0, 167.0, 197.0, 170.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 172.0, 199.0, 151.0, 187.0, 149.0, 212.0, 228.0, 205.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 68.0, 66.0, 64.0, 64.0, 65.0, 65.0], "value": 65.8, "unit": "score"}]}]} 03:24:13 INFO - Return code: 0 03:24:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:13 ERROR - # TBPL SUCCESS # 03:24:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:13 INFO - 2017-03-14 03:24:13.206 screenresolution[1972:18329] starting screenresolution argv=screenresolution get 03:24:13 INFO - 2017-03-14 03:24:13.209 screenresolution[1972:18329] Display 0: 1600x1200x32@60 03:24:13 INFO - 2017-03-14 03:24:13.215 screenresolution[1973:18332] starting screenresolution argv=screenresolution list 03:24:13 INFO - Available Modes on Display 0 03:24:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:13 INFO - Intel Iris: 03:24:13 INFO - Chipset Model: Intel Iris 03:24:13 INFO - Type: GPU 03:24:13 INFO - Bus: Built-In 03:24:13 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:13 INFO - Vendor: Intel (0x8086) 03:24:13 INFO - Device ID: 0x0a2e 03:24:13 INFO - Revision ID: 0x0009 03:24:13 INFO - Displays: 03:24:13 INFO - Display: 03:24:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:13 INFO - Display Serial Number: 1600x1200 60 03:24:13 INFO - Main Display: Yes 03:24:13 INFO - Mirror: Off 03:24:13 INFO - Online: Yes 03:24:13 INFO - Rotation: Supported 03:24:13 INFO - Return code: 0 03:24:13 INFO - Running post-action listener: _resource_record_post_action 03:24:13 INFO - [mozharness: 2017-03-14 10:24:13.453113Z] Finished run-tests step (success) 03:24:13 INFO - Running post-run listener: _resource_record_post_run 03:24:13 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 770048; Write bytes: 508294144; Read time: 9; Write time: 1635 03:24:13 INFO - TinderboxPrint: CPU usage
54.6% 03:24:13 INFO - TinderboxPrint: I/O read bytes / time
770,048 / 9 03:24:13 INFO - TinderboxPrint: I/O write bytes / time
508,294,144 / 1,635 03:24:13 INFO - TinderboxPrint: CPU idle
2,179.2 (45.4%) 03:24:13 INFO - TinderboxPrint: CPU system
963.5 (20.1%) 03:24:13 INFO - TinderboxPrint: CPU user
1,655.1 (34.5%) 03:24:13 INFO - TinderboxPrint: Swap in / out
209,301,504 / 0 03:24:13 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203909632; Write bytes: 202049024; Read time: 15537; Write time: 399 03:24:13 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 770048; Write bytes: 295370240; Read time: 9; Write time: 1200 03:24:13 INFO - Running post-run listener: _upload_blobber_files 03:24:13 INFO - Blob upload gear active. 03:24:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24:13 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:24:13 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:24:13 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:24:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:15 INFO - (blobuploader) - INFO - Done attempting. 03:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:16 INFO - (blobuploader) - INFO - Done attempting. 03:24:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:24:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:24:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:17 INFO - (blobuploader) - INFO - Done attempting. 03:24:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:20 INFO - (blobuploader) - INFO - Done attempting. 03:24:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:24:20 INFO - Return code: 0 03:24:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:24:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:24:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6d173e29f9e270c900bd478fc821003d0648672876d4c44f7bb8f5c25d0975db4471f53efa209404d5c652278f2b0936925c2615d0de49b4bf10a635ff5649", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2405799984cb0734bc2a7f9fdeb01115745a6b111e88bcf757d78bc7bb28a6de22fa4158333e629cf8d58f3e058801728d0a5fbc4418cfb8df70a096e0b71c1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28453e4714ccf602bd1a8b8579f93a467fff2d4f5725c0cda0095f83be64abcc1c1982dee6c47cda348caf664a5c1c590a1604b62b7c746e1fb89ac2955f9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c98f5cc7805664b7918f0e3e800dcb5d87ed7ebc4889a7f0cff9d9de5a9f21accda800b14824b284247a8dafff75cb3d7f0846785b0a71aad0f222c0b1bbd61"} 03:24:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:24:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:24:20 INFO - Contents: 03:24:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6d173e29f9e270c900bd478fc821003d0648672876d4c44f7bb8f5c25d0975db4471f53efa209404d5c652278f2b0936925c2615d0de49b4bf10a635ff5649", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2405799984cb0734bc2a7f9fdeb01115745a6b111e88bcf757d78bc7bb28a6de22fa4158333e629cf8d58f3e058801728d0a5fbc4418cfb8df70a096e0b71c1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28453e4714ccf602bd1a8b8579f93a467fff2d4f5725c0cda0095f83be64abcc1c1982dee6c47cda348caf664a5c1c590a1604b62b7c746e1fb89ac2955f9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c98f5cc7805664b7918f0e3e800dcb5d87ed7ebc4889a7f0cff9d9de5a9f21accda800b14824b284247a8dafff75cb3d7f0846785b0a71aad0f222c0b1bbd61"} 03:24:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:24:20 INFO - Copying logs to upload dir... 03:24:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:24:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.320552 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-14 03:24:20.476075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:20.479591) ========= 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.xbPLvjkEjo/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.K37H2dOfCN/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6d173e29f9e270c900bd478fc821003d0648672876d4c44f7bb8f5c25d0975db4471f53efa209404d5c652278f2b0936925c2615d0de49b4bf10a635ff5649", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2405799984cb0734bc2a7f9fdeb01115745a6b111e88bcf757d78bc7bb28a6de22fa4158333e629cf8d58f3e058801728d0a5fbc4418cfb8df70a096e0b71c1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28453e4714ccf602bd1a8b8579f93a467fff2d4f5725c0cda0095f83be64abcc1c1982dee6c47cda348caf664a5c1c590a1604b62b7c746e1fb89ac2955f9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c98f5cc7805664b7918f0e3e800dcb5d87ed7ebc4889a7f0cff9d9de5a9f21accda800b14824b284247a8dafff75cb3d7f0846785b0a71aad0f222c0b1bbd61"} build_url:https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/O5wGm_PfTHGsvXLAnSltJQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d6d173e29f9e270c900bd478fc821003d0648672876d4c44f7bb8f5c25d0975db4471f53efa209404d5c652278f2b0936925c2615d0de49b4bf10a635ff5649", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2405799984cb0734bc2a7f9fdeb01115745a6b111e88bcf757d78bc7bb28a6de22fa4158333e629cf8d58f3e058801728d0a5fbc4418cfb8df70a096e0b71c1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c28453e4714ccf602bd1a8b8579f93a467fff2d4f5725c0cda0095f83be64abcc1c1982dee6c47cda348caf664a5c1c590a1604b62b7c746e1fb89ac2955f9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c98f5cc7805664b7918f0e3e800dcb5d87ed7ebc4889a7f0cff9d9de5a9f21accda800b14824b284247a8dafff75cb3d7f0846785b0a71aad0f222c0b1bbd61"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:20.513279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:20.513615) ========= 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.xbPLvjkEjo/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.K37H2dOfCN/Listeners TMPDIR=/var/folders/l3/698npc0163s3r3bxv5kkw36r00000w/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.005355 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:24:20.561798) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 03:24:20.562075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 03:24:20.562369) ========= ========= Total master_lag: 0.19 =========