builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0007 starttime: 1478387733.07 results: success (0) buildid: 20161105060620 builduid: b916449ac61a4df986f58c0f4ee2b98e revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.070150) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.070552) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.070835) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.135237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.135487) ========= 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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-05 16:15:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.94M=0.001s 2016-11-05 16:15:33 (7.94 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.494070 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.655620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.655940) ========= 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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.019518 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.779469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.779850) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070cf059bb70aa991d50b4d266987adf26685915 --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 070cf059bb70aa991d50b4d266987adf26685915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aQ58rKYrUX/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.iHCwuzFAUB/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-05 16:15:33,861 truncating revision to first 12 chars 2016-11-05 16:15:33,861 Setting DEBUG logging. 2016-11-05 16:15:33,861 attempt 1/10 2016-11-05 16:15:33,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/070cf059bb70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 16:15:34,199 unpacking tar archive at: mozilla-aurora-070cf059bb70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589039 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.395262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.395568) ========= script_repo_revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.399075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.399374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.418119) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-05 16:15:34.418449) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aQ58rKYrUX/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.iHCwuzFAUB/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:15:34 INFO - MultiFileLogger online at 20161105 16:15:34 in /builds/slave/test 16:15:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:15:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:34 INFO - {'append_to_log': False, 16:15:34 INFO - 'base_work_dir': '/builds/slave/test', 16:15:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:15:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:34 INFO - 'branch': 'Mozilla-Aurora', 16:15:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:34 INFO - 'config_files': ('talos/mac_config.py',), 16:15:34 INFO - 'default_actions': ('clobber', 16:15:34 INFO - 'read-buildbot-config', 16:15:34 INFO - 'download-and-extract', 16:15:34 INFO - 'populate-webroot', 16:15:34 INFO - 'create-virtualenv', 16:15:34 INFO - 'install', 16:15:34 INFO - 'run-tests'), 16:15:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:34 INFO - 'download_minidump_stackwalk': True, 16:15:34 INFO - 'download_symbols': 'ondemand', 16:15:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:34 INFO - 'installer_path': 'installer.exe', 16:15:34 INFO - 'log_level': 'info', 16:15:34 INFO - 'log_name': 'talos', 16:15:34 INFO - 'log_to_console': True, 16:15:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:15:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:15:34 INFO - 'opt_config_files': (), 16:15:34 INFO - 'pip_index': False, 16:15:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:34 INFO - 'cmd': ('bash', 16:15:34 INFO - '-c', 16:15:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:34 INFO - 'enabled': True, 16:15:34 INFO - 'halt_on_failure': False, 16:15:34 INFO - 'name': 'check_screen_resolution'},), 16:15:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:34 INFO - 'cmd': ('bash', 16:15:34 INFO - '-c', 16:15:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:34 INFO - 'enabled': True, 16:15:34 INFO - 'halt_on_failure': False, 16:15:34 INFO - 'name': 'check_screen_resolution'},), 16:15:34 INFO - 'run_cmd_checks_enabled': True, 16:15:34 INFO - 'sps_profile': False, 16:15:34 INFO - 'sps_profile_interval': 0, 16:15:34 INFO - 'suite': 'dromaeojs', 16:15:34 INFO - 'system_bits': '32', 16:15:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:34 INFO - 'title': 't-yosemite-r7-0007', 16:15:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:34 INFO - 'use_talos_json': True, 16:15:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:34 INFO - 'work_dir': 'build'} 16:15:34 INFO - [mozharness: 2016-11-05 23:15:34.617771Z] Running clobber step. 16:15:34 INFO - Running pre-action listener: _resource_record_pre_action 16:15:34 INFO - Running main action method: clobber 16:15:34 INFO - rmtree: /builds/slave/test/build 16:15:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:35 INFO - Running post-action listener: _resource_record_post_action 16:15:35 INFO - [mozharness: 2016-11-05 23:15:35.248081Z] Finished clobber step (success) 16:15:35 INFO - [mozharness: 2016-11-05 23:15:35.248242Z] Running read-buildbot-config step. 16:15:35 INFO - Running pre-action listener: _resource_record_pre_action 16:15:35 INFO - Running main action method: read_buildbot_config 16:15:35 INFO - Using buildbot properties: 16:15:35 INFO - { 16:15:35 INFO - "project": "", 16:15:35 INFO - "product": "firefox", 16:15:35 INFO - "script_repo_revision": "production", 16:15:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:15:35 INFO - "repository": "", 16:15:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:15:35 INFO - "buildid": "20161105060620", 16:15:35 INFO - "pgo_build": "False", 16:15:35 INFO - "basedir": "/builds/slave/test", 16:15:35 INFO - "buildnumber": 21, 16:15:35 INFO - "slavename": "t-yosemite-r7-0007", 16:15:35 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:15:35 INFO - "platform": "yosemite_r7", 16:15:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:15:35 INFO - "branch": "mozilla-aurora", 16:15:35 INFO - "repo_path": "releases/mozilla-aurora", 16:15:35 INFO - "revision": "070cf059bb70aa991d50b4d266987adf26685915", 16:15:35 INFO - "stage_platform": "macosx64", 16:15:35 INFO - "builduid": "b916449ac61a4df986f58c0f4ee2b98e", 16:15:35 INFO - "slavebuilddir": "test" 16:15:35 INFO - } 16:15:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:15:35 INFO - Running post-action listener: _resource_record_post_action 16:15:35 INFO - [mozharness: 2016-11-05 23:15:35.251534Z] Finished read-buildbot-config step (success) 16:15:35 INFO - [mozharness: 2016-11-05 23:15:35.251659Z] Running download-and-extract step. 16:15:35 INFO - Running pre-action listener: _resource_record_pre_action 16:15:35 INFO - Running main action method: download_and_extract 16:15:35 INFO - mkdir: /builds/slave/test/build/tests 16:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:35 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:35 INFO - Downloading https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:15:36 INFO - Downloaded 1199 bytes. 16:15:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:36 INFO - Using the following test package requirements: 16:15:36 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:15:36 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:15:36 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:15:36 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'jsshell-mac.zip'], 16:15:36 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:15:36 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:15:36 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:15:36 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:15:36 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:15:36 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:36 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:15:36 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:15:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:15:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:36 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:15:37 INFO - Expected file size: 16421523 16:15:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:15:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:15:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:44 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:15:45 INFO - Expected file size: 16421523 16:15:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:15:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:15:51 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:15:52 INFO - Expected file size: 14414089 16:15:53 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')]} 16:15:53 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:53 INFO - Downloading https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:15:56 INFO - Downloaded 115457788 bytes. 16:15:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:56 INFO - mkdir: /builds/slave/test/properties 16:15:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:56 INFO - Contents: 16:15:56 INFO - build_url:https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:57 INFO - Running post-action listener: _resource_record_post_action 16:15:57 INFO - Running post-action listener: set_extra_try_arguments 16:15:57 INFO - [mozharness: 2016-11-05 23:15:57.166336Z] Finished download-and-extract step (success) 16:15:57 INFO - [mozharness: 2016-11-05 23:15:57.166439Z] Running populate-webroot step. 16:15:57 INFO - Running pre-action listener: _resource_record_pre_action 16:15:57 INFO - Running main action method: populate_webroot 16:15:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:57 INFO - '--tppagecycles', 16:15:57 INFO - '7'], 16:15:57 INFO - 'tests': ['tsvgm']}}, 16:15:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['damp', 'tps']}, 16:15:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'tests': ['damp', 'tps']}, 16:15:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['dromaeo_dom']}, 16:15:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['basic_compositor_video']}, 16:15:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:15:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['a11yr', 16:15:57 INFO - 'ts_paint', 16:15:57 INFO - 'tpaint', 16:15:57 INFO - 'sessionrestore', 16:15:57 INFO - 'sessionrestore_no_auto_restore', 16:15:57 INFO - 'tabpaint']}, 16:15:57 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:57 INFO - 'ts_paint', 16:15:57 INFO - 'tpaint', 16:15:57 INFO - 'sessionrestore', 16:15:57 INFO - 'sessionrestore_no_auto_restore', 16:15:57 INFO - 'tabpaint']}, 16:15:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:15:57 INFO - 'ts_paint', 16:15:57 INFO - 'tpaint', 16:15:57 INFO - 'sessionrestore', 16:15:57 INFO - 'sessionrestore_no_auto_restore', 16:15:57 INFO - 'tabpaint']}, 16:15:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:15:57 INFO - 'ts_paint', 16:15:57 INFO - 'tpaint', 16:15:57 INFO - 'sessionrestore', 16:15:57 INFO - 'sessionrestore_no_auto_restore', 16:15:57 INFO - 'tabpaint']}, 16:15:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['a11yr', 16:15:57 INFO - 'ts_paint', 16:15:57 INFO - 'tpaint', 16:15:57 INFO - 'sessionrestore', 16:15:57 INFO - 'sessionrestore_no_auto_restore', 16:15:57 INFO - 'tabpaint']}, 16:15:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['a11yr', 16:15:57 INFO - 'ts_paint', 16:15:57 INFO - 'tpaint', 16:15:57 INFO - 'sessionrestore', 16:15:57 INFO - 'sessionrestore_no_auto_restore', 16:15:57 INFO - 'tabpaint']}, 16:15:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['tsvgx', 16:15:57 INFO - 'tsvgr_opacity', 16:15:57 INFO - 'tart', 16:15:57 INFO - 'tscrollx', 16:15:57 INFO - 'cart']}, 16:15:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:57 INFO - 'tsvgr_opacity', 16:15:57 INFO - 'tart', 16:15:57 INFO - 'tscrollx', 16:15:57 INFO - 'cart']}, 16:15:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'talos_options': ['--disable-e10s'], 16:15:57 INFO - 'tests': ['tp5o']}, 16:15:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'tests': ['tp5o']}, 16:15:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'talos_options': ['--disable-e10s', 16:15:57 INFO - '--xperf_path', 16:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:57 INFO - 'tests': ['tp5n']}, 16:15:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:57 INFO - 'talos_options': ['--xperf_path', 16:15:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:57 INFO - 'tests': ['tp5n']}}, 16:15:57 INFO - 'talos.zip': {'path': '', 16:15:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:57 INFO - Running post-action listener: _resource_record_post_action 16:15:57 INFO - [mozharness: 2016-11-05 23:15:57.185041Z] Finished populate-webroot step (success) 16:15:57 INFO - [mozharness: 2016-11-05 23:15:57.185168Z] Running create-virtualenv step. 16:15:57 INFO - Running pre-action listener: _resource_record_pre_action 16:15:57 INFO - Running main action method: create_virtualenv 16:15:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:57 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 16:15:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:57 INFO - Using real prefix '/tools/python27' 16:15:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:15:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:00 INFO - Installing pip.................done. 16:16:00 INFO - Return code: 0 16:16:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:16:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:00 INFO - 'HOME': '/Users/cltbld', 16:16:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:00 INFO - 'LOGNAME': 'cltbld', 16:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:00 INFO - 'MOZ_NO_REMOTE': '1', 16:16:00 INFO - 'NO_EM_RESTART': '1', 16:16:00 INFO - 'PAGER': '/bin/cat', 16:16:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:00 INFO - 'PWD': '/builds/slave/test', 16:16:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:00 INFO - 'SHELL': '/bin/bash', 16:16:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:00 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:00 INFO - 'USER': 'cltbld', 16:16:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:00 INFO - 'XPC_FLAGS': '0x0', 16:16:00 INFO - 'XPC_SERVICE_NAME': '0', 16:16:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:01 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 16:16:01 INFO - Cleaning up... 16:16:01 INFO - Return code: 0 16:16:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:01 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:01 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 16:16:01 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 16:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:01 INFO - 'HOME': '/Users/cltbld', 16:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:01 INFO - 'LOGNAME': 'cltbld', 16:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:01 INFO - 'MOZ_NO_REMOTE': '1', 16:16:01 INFO - 'NO_EM_RESTART': '1', 16:16:01 INFO - 'PAGER': '/bin/cat', 16:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:01 INFO - 'PWD': '/builds/slave/test', 16:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:01 INFO - 'SHELL': '/bin/bash', 16:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:01 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:01 INFO - 'USER': 'cltbld', 16:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:01 INFO - 'XPC_FLAGS': '0x0', 16:16:01 INFO - 'XPC_SERVICE_NAME': '0', 16:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:01 INFO - Downloading/unpacking psutil>=3.1.1 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:05 INFO - Installing collected packages: psutil 16:16:05 INFO - Running setup.py install for psutil 16:16:05 INFO - building 'psutil._psutil_osx' extension 16:16:05 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 16:16:05 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 16:16:05 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 16:16:05 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 16:16:05 INFO - building 'psutil._psutil_posix' extension 16:16:05 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 16:16:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:16:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:16:05 INFO - ^ 16:16:05 INFO - 1 warning generated. 16:16:05 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 16:16:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:06 INFO - Successfully installed psutil 16:16:06 INFO - Cleaning up... 16:16:06 INFO - Return code: 0 16:16:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:06 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:06 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 16:16:06 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 16:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:06 INFO - 'HOME': '/Users/cltbld', 16:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:06 INFO - 'LOGNAME': 'cltbld', 16:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:06 INFO - 'MOZ_NO_REMOTE': '1', 16:16:06 INFO - 'NO_EM_RESTART': '1', 16:16:06 INFO - 'PAGER': '/bin/cat', 16:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:06 INFO - 'PWD': '/builds/slave/test', 16:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:06 INFO - 'SHELL': '/bin/bash', 16:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:06 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:06 INFO - 'USER': 'cltbld', 16:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:06 INFO - 'XPC_FLAGS': '0x0', 16:16:06 INFO - 'XPC_SERVICE_NAME': '0', 16:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:08 INFO - Installing collected packages: mozsystemmonitor 16:16:08 INFO - Running setup.py install for mozsystemmonitor 16:16:09 INFO - Successfully installed mozsystemmonitor 16:16:09 INFO - Cleaning up... 16:16:09 INFO - Return code: 0 16:16:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16:09 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')]} 16:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:09 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')]} 16:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:09 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:09 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 16:16:09 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 16:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:09 INFO - 'HOME': '/Users/cltbld', 16:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:09 INFO - 'LOGNAME': 'cltbld', 16:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:09 INFO - 'MOZ_NO_REMOTE': '1', 16:16:09 INFO - 'NO_EM_RESTART': '1', 16:16:09 INFO - 'PAGER': '/bin/cat', 16:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:09 INFO - 'PWD': '/builds/slave/test', 16:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:09 INFO - 'SHELL': '/bin/bash', 16:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:09 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:09 INFO - 'USER': 'cltbld', 16:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:09 INFO - 'XPC_FLAGS': '0x0', 16:16:09 INFO - 'XPC_SERVICE_NAME': '0', 16:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:09 INFO - Downloading/unpacking jsonschema==2.5.1 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:12 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:12 INFO - warning: no files found matching '*.txt' 16:16:12 INFO - no previously-included directories found matching 'build' 16:16:12 INFO - no previously-included directories found matching 'dist' 16:16:12 INFO - no previously-included directories found matching '.git*' 16:16:12 INFO - Installing collected packages: jsonschema, functools32 16:16:12 INFO - Running setup.py install for functools32 16:16:12 INFO - warning: no files found matching '*.txt' 16:16:12 INFO - no previously-included directories found matching 'build' 16:16:12 INFO - no previously-included directories found matching 'dist' 16:16:12 INFO - no previously-included directories found matching '.git*' 16:16:12 INFO - Successfully installed jsonschema functools32 16:16:12 INFO - Cleaning up... 16:16:12 INFO - Return code: 0 16:16:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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', '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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:16: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 functools32==3.2.3-2 16:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:12 INFO - 'HOME': '/Users/cltbld', 16:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:12 INFO - 'LOGNAME': 'cltbld', 16:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:12 INFO - 'MOZ_NO_REMOTE': '1', 16:16:12 INFO - 'NO_EM_RESTART': '1', 16:16:12 INFO - 'PAGER': '/bin/cat', 16:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:12 INFO - 'PWD': '/builds/slave/test', 16:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:12 INFO - 'SHELL': '/bin/bash', 16:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:12 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:12 INFO - 'USER': 'cltbld', 16:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:12 INFO - 'XPC_FLAGS': '0x0', 16:16:12 INFO - 'XPC_SERVICE_NAME': '0', 16:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:16:13 INFO - Cleaning up... 16:16:13 INFO - Return code: 0 16:16:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:16:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:13 INFO - 'HOME': '/Users/cltbld', 16:16:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:13 INFO - 'LOGNAME': 'cltbld', 16:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:13 INFO - 'MOZ_NO_REMOTE': '1', 16:16:13 INFO - 'NO_EM_RESTART': '1', 16:16:13 INFO - 'PAGER': '/bin/cat', 16:16:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:13 INFO - 'PWD': '/builds/slave/test', 16:16:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:13 INFO - 'SHELL': '/bin/bash', 16:16:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:13 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:13 INFO - 'USER': 'cltbld', 16:16:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:13 INFO - 'XPC_FLAGS': '0x0', 16:16:13 INFO - 'XPC_SERVICE_NAME': '0', 16:16:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:13 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:15 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:16 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 16:16:16 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 16:16:16 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 16:16:16 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 16:16:16 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 16:16:16 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 16:16:17 INFO - Downloading docopt-0.6.1.tar.gz 16:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:17 INFO - Running setup.py install for blobuploader 16:16:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:17 INFO - Running setup.py install for requests 16:16:17 INFO - Running setup.py install for docopt 16:16:17 INFO - Successfully installed blobuploader requests docopt 16:16:17 INFO - Cleaning up... 16:16:18 INFO - Return code: 0 16:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:18 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')]} 16:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:18 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')]} 16:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:18 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:18 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 16:16:18 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 16:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:18 INFO - 'HOME': '/Users/cltbld', 16:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:18 INFO - 'LOGNAME': 'cltbld', 16:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:18 INFO - 'MOZ_NO_REMOTE': '1', 16:16:18 INFO - 'NO_EM_RESTART': '1', 16:16:18 INFO - 'PAGER': '/bin/cat', 16:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:18 INFO - 'PWD': '/builds/slave/test', 16:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:18 INFO - 'SHELL': '/bin/bash', 16:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:18 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:18 INFO - 'USER': 'cltbld', 16:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:18 INFO - 'XPC_FLAGS': '0x0', 16:16:18 INFO - 'XPC_SERVICE_NAME': '0', 16:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-IMYd8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-mFY6WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-rHjyHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-afQMpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-bSN1Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-XJ3KgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:18 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-SQhB67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lz8Rma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-vVXfsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-v5rtSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-g1BWpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lewpjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-GTpaOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-IxpOLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-NBpWB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:19 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-8c1V4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:20 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3KK0Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:20 INFO - Running setup.py install for manifestparser 16:16:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozcrash 16:16:20 INFO - Running setup.py install for mozdebug 16:16:20 INFO - Running setup.py install for mozdevice 16:16:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozfile 16:16:20 INFO - Running setup.py install for mozhttpd 16:16:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for mozinfo 16:16:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for mozInstall 16:16:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for mozleak 16:16:21 INFO - Running setup.py install for mozlog 16:16:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for moznetwork 16:16:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for mozprocess 16:16:21 INFO - Running setup.py install for mozprofile 16:16:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Running setup.py install for mozrunner 16:16:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Running setup.py install for mozscreenshot 16:16:22 INFO - Running setup.py install for moztest 16:16:22 INFO - Running setup.py install for mozversion 16:16:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:22 INFO - Cleaning up... 16:16:22 INFO - Return code: 0 16:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:22 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:22 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 16:16:22 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 16:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:22 INFO - 'HOME': '/Users/cltbld', 16:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:22 INFO - 'LOGNAME': 'cltbld', 16:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:22 INFO - 'MOZ_NO_REMOTE': '1', 16:16:22 INFO - 'NO_EM_RESTART': '1', 16:16:22 INFO - 'PAGER': '/bin/cat', 16:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:22 INFO - 'PWD': '/builds/slave/test', 16:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:22 INFO - 'SHELL': '/bin/bash', 16:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:22 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:22 INFO - 'USER': 'cltbld', 16:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:22 INFO - 'XPC_FLAGS': '0x0', 16:16:22 INFO - 'XPC_SERVICE_NAME': '0', 16:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ERUAkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:23 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)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-d_zAuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-f1M0U7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:23 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)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-4uCWVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-WdYnZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:23 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)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-U3pP64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:23 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)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-5XJ0dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:23 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)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-vj4pHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:23 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)) 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:23 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-inw6Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:24 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)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-HgwVix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:24 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)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-skMdtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:24 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)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_lPkEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-x5HxOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:24 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)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-zyhL6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-efDzc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:24 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)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ZTyICU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:24 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Nytttt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:24 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)) 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:16:24 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)) 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:24 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 16:16:24 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 16:16:24 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 16:16:24 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 16:16:24 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 16:16:24 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 16:16:27 INFO - Downloading blessings-1.6.tar.gz 16:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:27 INFO - Installing collected packages: blessings 16:16:27 INFO - Running setup.py install for blessings 16:16:27 INFO - Successfully installed blessings 16:16:27 INFO - Cleaning up... 16:16:27 INFO - Return code: 0 16:16:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:28 INFO - Reading from file tmpfile_stdout 16:16:28 INFO - Current package versions: 16:16:28 INFO - blessings == 1.6 16:16:28 INFO - blobuploader == 1.2.4 16:16:28 INFO - docopt == 0.6.1 16:16:28 INFO - functools32 == 3.2.3-2 16:16:28 INFO - jsonschema == 2.5.1 16:16:28 INFO - manifestparser == 1.1 16:16:28 INFO - mozInstall == 1.12 16:16:28 INFO - mozcrash == 0.17 16:16:28 INFO - mozdebug == 0.1 16:16:28 INFO - mozdevice == 0.48 16:16:28 INFO - mozfile == 1.2 16:16:28 INFO - mozhttpd == 0.7 16:16:28 INFO - mozinfo == 0.9 16:16:28 INFO - mozleak == 0.1 16:16:28 INFO - mozlog == 3.4 16:16:28 INFO - moznetwork == 0.27 16:16:28 INFO - mozprocess == 0.23 16:16:28 INFO - mozprofile == 0.28 16:16:28 INFO - mozrunner == 6.12 16:16:28 INFO - mozscreenshot == 0.1 16:16:28 INFO - mozsystemmonitor == 0.3 16:16:28 INFO - moztest == 0.7 16:16:28 INFO - mozversion == 1.4 16:16:28 INFO - psutil == 3.1.1 16:16:28 INFO - requests == 1.2.3 16:16:28 INFO - wsgiref == 0.1.2 16:16:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:28 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')]} 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:28 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')]} 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:28 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:28 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 16:16:28 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 16:16:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:28 INFO - 'HOME': '/Users/cltbld', 16:16:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:28 INFO - 'LOGNAME': 'cltbld', 16:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:28 INFO - 'MOZ_NO_REMOTE': '1', 16:16:28 INFO - 'NO_EM_RESTART': '1', 16:16:28 INFO - 'PAGER': '/bin/cat', 16:16:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:28 INFO - 'PWD': '/builds/slave/test', 16:16:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:28 INFO - 'SHELL': '/bin/bash', 16:16:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:28 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:28 INFO - 'USER': 'cltbld', 16:16:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:28 INFO - 'XPC_FLAGS': '0x0', 16:16:28 INFO - 'XPC_SERVICE_NAME': '0', 16:16:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 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)) 16:16:28 INFO - Cleaning up... 16:16:28 INFO - Return code: 0 16:16:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:16:28 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')]} 16:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:28 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')]} 16:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:28 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 0x10232d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facfa58c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, '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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 16:16:28 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 16:16:28 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 16:16:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:16:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:28 INFO - 'HOME': '/Users/cltbld', 16:16:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:28 INFO - 'LOGNAME': 'cltbld', 16:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:28 INFO - 'MOZ_NO_REMOTE': '1', 16:16:28 INFO - 'NO_EM_RESTART': '1', 16:16:28 INFO - 'PAGER': '/bin/cat', 16:16:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:28 INFO - 'PWD': '/builds/slave/test', 16:16:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:28 INFO - 'SHELL': '/bin/bash', 16:16:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:16:28 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:16:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:28 INFO - 'USER': 'cltbld', 16:16:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:28 INFO - 'XPC_FLAGS': '0x0', 16:16:28 INFO - 'XPC_SERVICE_NAME': '0', 16:16:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:16:28 INFO - Cleaning up... 16:16:28 INFO - Return code: 0 16:16:28 INFO - Running post-action listener: _resource_record_post_action 16:16:28 INFO - Running post-action listener: _start_resource_monitoring 16:16:28 INFO - Starting resource monitoring. 16:16:28 INFO - [mozharness: 2016-11-05 23:16:28.650726Z] Finished create-virtualenv step (success) 16:16:28 INFO - [mozharness: 2016-11-05 23:16:28.651770Z] Running install step. 16:16:28 INFO - Running pre-action listener: _resource_record_pre_action 16:16:28 INFO - Running main action method: install 16:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:28 INFO - Reading from file tmpfile_stdout 16:16:28 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:29 INFO - Reading from file tmpfile_stdout 16:16:29 INFO - Output received: 16:16:29 INFO - Usage: mozinstall [options] installer 16:16:29 INFO - Options: 16:16:29 INFO - -h, --help show this help message and exit 16:16:29 INFO - -d DEST, --destination=DEST 16:16:29 INFO - Directory to install application into. [default: 16:16:29 INFO - "/builds/slave/test"] 16:16:29 INFO - --app=APP Application being installed. [default: firefox] 16:16:29 INFO - mkdir: /builds/slave/test/build/application 16:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:17:01 INFO - Reading from file tmpfile_stdout 16:17:01 INFO - Output received: 16:17:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:17:01 INFO - Running post-action listener: _resource_record_post_action 16:17:01 INFO - [mozharness: 2016-11-05 23:17:01.127831Z] Finished install step (success) 16:17:01 INFO - [mozharness: 2016-11-05 23:17:01.127991Z] Running run-tests step. 16:17:01 INFO - Running pre-action listener: _resource_record_pre_action 16:17:01 INFO - Running main action method: run_tests 16:17:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:01 INFO - 2016-11-05 16:17:01.142 screenresolution[6439:119542] starting screenresolution argv=screenresolution get 16:17:01 INFO - 2016-11-05 16:17:01.145 screenresolution[6439:119542] Display 0: 1600x1200x32@60 16:17:01 INFO - 2016-11-05 16:17:01.151 screenresolution[6440:119545] starting screenresolution argv=screenresolution list 16:17:01 INFO - Available Modes on Display 0 16:17:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:01 INFO - Intel Iris: 16:17:01 INFO - Chipset Model: Intel Iris 16:17:01 INFO - Type: GPU 16:17:01 INFO - Bus: Built-In 16:17:01 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:01 INFO - Vendor: Intel (0x8086) 16:17:01 INFO - Device ID: 0x0a2e 16:17:01 INFO - Revision ID: 0x0009 16:17:01 INFO - Displays: 16:17:01 INFO - Display: 16:17:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:01 INFO - Display Serial Number: 1600x1200 60 16:17:01 INFO - Main Display: Yes 16:17:01 INFO - Mirror: Off 16:17:01 INFO - Online: Yes 16:17:01 INFO - Rotation: Supported 16:17:01 INFO - Return code: 0 16:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:01 INFO - Python 2.7.3 16:17:01 INFO - Return code: 0 16:17:01 INFO - grabbing minidump binary from tooltool 16:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:01 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 0x102141d30>, '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 0x101fa7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102139b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:01 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 16:17:01 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 16:17:01 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 16:17:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:01 INFO - Return code: 0 16:17:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:17:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:17:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aQ58rKYrUX/Render', 16:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:01 INFO - 'HOME': '/Users/cltbld', 16:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:01 INFO - 'LOGNAME': 'cltbld', 16:17:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:01 INFO - 'MOZ_NO_REMOTE': '1', 16:17:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:01 INFO - 'NO_EM_RESTART': '1', 16:17:01 INFO - 'PAGER': '/bin/cat', 16:17:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:01 INFO - 'PWD': '/builds/slave/test', 16:17:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:01 INFO - 'SHELL': '/bin/bash', 16:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHCwuzFAUB/Listeners', 16:17:01 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 16:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:01 INFO - 'USER': 'cltbld', 16:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:01 INFO - 'XPC_FLAGS': '0x0', 16:17:01 INFO - 'XPC_SERVICE_NAME': '0', 16:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:17:01 INFO - mozversion application_buildid: 20161105060620 16:17:01 INFO - mozversion application_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:17:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:01 INFO - mozversion application_name: Firefox 16:17:01 INFO - mozversion application_remotingname: firefox-dev 16:17:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:01 INFO - mozversion application_vendor: Mozilla 16:17:01 INFO - mozversion application_version: 51.0a2 16:17:01 INFO - mozversion platform_buildid: 20161105060620 16:17:01 INFO - mozversion platform_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:01 INFO - mozversion platform_version: 51.0a2 16:17:01 INFO - using testdate: 1478387821 16:17:01 INFO - actual date: 1478387821 16:17:01 INFO - starting webserver on 'localhost:57508' 16:17:01 INFO - SUITE-START | Running 2 tests 16:17:01 INFO - TEST-START | dromaeo_css 16:17:01 INFO - operating with platform_type : mac_ 16:17:01 INFO - Initialising browser for dromaeo_css test... 16:17:01 INFO - TEST-INFO | started process 6450 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpMmahSW/profile http://localhost:57508/getInfo.html) 16:17:04 INFO - PROCESS | 6450 | __metrics Screen width/height:1600/1200 16:17:04 INFO - PROCESS | 6450 | colorDepth:24 16:17:04 INFO - PROCESS | 6450 | Browser inner width/height: 1024/689 16:17:04 INFO - PROCESS | 6450 | __metrics 16:17:04 INFO - PROCESS | 6450 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:17:04 INFO - PROCESS | 6450 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:17:04 INFO - TEST-INFO | 6450: exit 0 16:17:04 INFO - Browser initialized. 16:17:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:04 INFO - TEST-INFO | started process 6453 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpMmahSW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:16 INFO - PROCESS | 6453 | RSS: Main: 219598848 16:17:17 INFO - PROCESS | 6453 | 16:18:08 INFO - PROCESS | 6453 | 1478387888248 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:20:20 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:57508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57508/tests/dromaeo/cssquery-ext.html) 16:20:22 INFO - PROCESS | 6453 | RSS: Main: 370348032 16:20:22 INFO - PROCESS | 6453 | 16:23:25 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:57508/tests/dromaeo/cssquery-ext.html (next: http://localhost:57508/tests/dromaeo/cssquery-jquery.html) 16:23:25 INFO - PROCESS | 6453 | RSS: Main: 353480704 16:23:25 INFO - PROCESS | 6453 | 16:26:28 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:57508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57508/tests/dromaeo/cssquery-mootools.html) 16:26:28 INFO - PROCESS | 6453 | RSS: Main: 350019584 16:26:28 INFO - PROCESS | 6453 | 16:29:31 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:57508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57508/tests/dromaeo/cssquery-prototype.html) 16:29:31 INFO - PROCESS | 6453 | RSS: Main: 317890560 16:29:31 INFO - PROCESS | 6453 | 16:32:35 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:57508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57508/tests/dromaeo/cssquery-yui.html) 16:32:35 INFO - PROCESS | 6453 | RSS: Main: 313438208 16:32:35 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:57508/tests/dromaeo/cssquery-yui.html (next: http://localhost:57508/tests/dromaeo/cssquery-dojo.html) 16:35:39 INFO - PROCESS | 6453 | RSS: Main: 370167808 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | __start_tp_report 16:35:39 INFO - PROCESS | 6453 | _x_x_mozilla_page_load 16:35:39 INFO - PROCESS | 6453 | _x_x_mozilla_page_load_details 16:35:39 INFO - PROCESS | 6453 | |i|pagename|runs| 16:35:39 INFO - PROCESS | 6453 | |0;dojo.html;3301.2902226021406;3304.7190988765947;3318.800871947682;3330;3364.495325701146;5671.8298451046485;5719.571032172583;5757.050086735689;5778.566607504444;5823.854403639911;5662.773489060432;5744.511716504092;5756.769729210837;5760.7407666655;5777.480026797587;5206.895862082756;5223.947760522384;5241.606879484035;5247.239150323191;5275.894482110355;5191.818286359978;5217.217417387404;5308.938212357524;5329.546988505962;5337.5196232339085;5227.320448341729;5242.082635538784;5262.894742105155;5272.367315922094;5283.260343551887;5248.0815857225025;5279.208118782213;5280.392754833205;5310.62825602208;5340.813071542516;5188.5849132069725;5237.869053273661;5244.475552444763;5282.735863206863;5290.206469029677;4766.52334766524;5527.226188333637;5603.271574695264;5603.7478313475995;5604.635698679614;6173.969130154321;6209.285932117819;6214.316425193225;6231;6232.3144454110015;6214.906776398358;6238.095476155932;6255.812325630239;6276.121343011982;6380.106785050097;5018.573421259161;5736.368999410061;5737.053386191274;5741.88516229673;5781.53747700183;6178.289496707936;6190.659513726789;6254.562180647402;6259.248890133122;6285.088662143963;6209.316975132731;6213.161223234896;6217.440430361289;6218.782342617987;6219.720112594944;6086.513078953673;6141.846453838601;6175.197224360894;6261;6275.874482510324;6140.8771824564155;6149;6162.5378096642935;6219.968900155561;6238.65687387189;5625.690587017753;6239.937600624026;6286.842828929313;6292.182016337847;6325.082862984841;4736.905261894743;4877.6341774367065;4949.3611639463525;4963.70217786934;4971.279164521125;3802.2585595809105;4387.341898715218;4420.049689316812;4437.0460351024685;4445.533219012022;5853.912191317134;5865.853353666107;5873.177755114288;5874.50066744323;5896.734646940898;6226.283977342573;6245.75016999324;6264.373562643699;6269.185005949197;6271.27880293763;5590.888182236414;5718.51392631631;5729.512991395694;5831.475167234885;5896.528277737771;5335.706536140472;5343.225232341289;5385.299911011622;5390.137577987503;5400.648957817729;6251.593646412968;6263;6269.498440124779;6272.529560283088;6280.560360774702;6144.139820425234;6254.186955695731;6273.341299163522;6277.372262773686;6286.748530058747;6199.1011303359855;6257.906131408124;6263.843403914939;6268.592541484789;6271.905921411274;6194.473469755121;6258.655773932477;6267.2165979252595;6291.591046581958;6292.2134733158355;6161.784337548164;6184.072389141665;6250.468710159687;6250.9998400255745;6276.309605943251;6000.279966404059;6047.0627052806885;6074.301455332693;6092.329843717276;6171.6297022178815;5386.946130538645;6113.480354169946;6156.661383623944;6197.690115494297;6198.783042593668;6040.516758659384;6047.153398524122;6057.909131362945;6066.363031881765;6077.392260773887;6041.2750469943885;6083.422074902877;6138.815835524942;6140.109684095871;6214.130021796862;5968.671723055274;6043.667598282137;6060.303065147565;6114.052321890114;6125.989211780006 16:35:39 INFO - PROCESS | 6453 | |1;ext.html;464.48442229125664;475.36301356182713;492.8841722195286;512.3518748782791;513.3147248423354;29893.402131957377;39298;40449.39325910114;40454.19091618166;43276.350854737204;42317.57682423175;42697.7865110674;42699.57300426995;42771.57228427715;43050;9701.854472182906;9878.110970012698;9889.307748457612;9889.703308900744;9891.653792117277;8713.520756358397;9001.819963600725;11867;12121.878781212206;12129.878701212963;11999.40002999851;12081.577144799934;12089.879101209008;12097.879021209807;12098.697532561713;8848.955755221246;12107.273563586168;12179.573714920023;12204.267743935303;12219.327936963418;8768.517731524764;11676.416179191092;12029.93985030078;12030.578929737418;12241.69395765113;40286.39570406446;40730.796346018375;40760;40801.59198408008;41039;3340.28183940454;3398.371301309241;3410.2326976430354;3425.6060553036473;3520.9295814083575;29922;31233;31305;31509.951853129704;32010.199745006328;2881.121258016304;3253.837308134584;3255.3814775192636;3291.9835400822844;3384.678455546744;521927;523157;523510.38244808913;523604;523692.9999999962;32520;32815.671843281736;33077.503837442455;34922.9523114307;55943;35321.470177947354;35392.646073538934;35395.469067964004;35411.4688279676;35425.114372140386;14964.401423943138;14986;14988.850111498963;15061.849381506045;15115;11512.712182195512;11855.17013809025;12856.357182140855;12889.677758055936;12975.026872984376;7555.206703296185;7745.380369570421;7755.30202281786;7802.453828231969;7922.128565857751;3170.682931706811;3241.6434192238835;3245.6105267368066;3273.214428537134;3276.3447310537513;862.4480332587149;985.522021819417;1019.6074511313197;1042.0517329230363;1095.8356246562919;29840;29869.850650746608;30141;30281.848590756905;30537.08388748341;966.9669075844719;1071.994640026795;1072.3030030480095;1087.7878813631423;1116.7375666718315;14970.401183952737;15310.693786124439;15315.770263446057;15606.765898511532;15691.686166276839;745217;750280;751598;753497;753925;33469;33609.49585756216;40595;40673.59326406698;40684.77945661635;1229.8401207842924;1256.8617452080264;1261.4008346035744;1347.528365072256;1366.2622184020518;29006.56490152607;30314.393712126075;30422.391552169276;30585.860193132015;30701.846490768297;46970.53029469662;47219.763901180275;47434;47564;47647.76176119097;411656;482111;482433;482578.58710707625;482816;25771.742282576935;26548.734512654628;26903.05839295615;27281.181564553095;27588.724112758617;38680;38808.80595597004;44706.3294050583;45542.77228613836;47205.527944721485;37007;37431.43852842155;37935.62064379321;39042.609573905036;39247.2150556993;37183.442248365754;38057.238855223295;38580.614193857706;39326;39601.603983959794;36473.452898206015;37098.6290137106;37607.62392376041;37828;38249.4262586067;31571.36857262888;34213;34533.13667158341;35466.78064490449;35981.820090899375;21590.00822675978;23139.190128345428;25614.74385256198;25637.743622563536;25850.870745646906 16:35:39 INFO - PROCESS | 6453 | |2;jquery.html;352.66144501278774;372.270350113777;375.44621683017544;383.40189304684696;402.5451240098688;14911.776323355158;15177.39290428383;16511.266317036705;20021;20631.69052464214;18841.340553080645;19393.321233756822;19774.011299435006;20044.498887527818;20261.797382026176;5827.71790206155;5842.678652674102;5937.2578427696535;5939.960506911273;6096.908546371808;5879.11813228017;5942.821715348547;6010.549208809335;6011.819645410645;6014.248218972629;5685.317761868581;5879.588428809985;5954.345022047572;5975.223220981288;5985.700714964234;5920.851978700523;5958.433948774859;5965.22452081231;5968.46283834457;5969.552283578749;4245.341971994346;5199;5204.531592156724;5546.389897111315;5574.749136288877;13205.86794132056;13218.07473476857;13297.734045319135;13439.328033598282;13470.461181552726;2071.295759441797;2198.8131008864266;2248.4041728941843;2641.947161056768;2657.7873770098345;9965.302428829984;10129.594816207344;12392.81410778839;13734.725305493934;15497.690046199014;1824.9361272355536;1843.419322913278;1861.2275905499203;1915.5019694879431;1944.2903340280695;115699;116167.4191629045;116230;116998.41500792441;118051.40974295074;8944.195022448012;11059.281146725438;11436.913493218131;11694.70763230926;11832.88167118335;11886.762264754656;12354.876451235372;14722.411103555738;14727;14732.042417242845;7474.514156579914;8039.196080391914;8200.958995204986;8338.749837504885;8352.164783521599;8652.04827468978;8658.610362533702;8694.782630434163;8785.604647790864;8823.338249631302;3835.271298453285;3928.9017774555864;3953.367461206251;3973.5827738087664;3979.3036218662196;1907.637548865711;1957.9314723984878;1959.1477707197414;1959.2554829164826;1959.6080783843004;740.2338579570227;793.773774474272;809.380823669893;813.0527934955828;831.1439217605875;18209.45371638853;18378.08109594515;18984.43046708601;19017.809821901603;19269.4219173425;833.2833762963846;846.7713717296418;857.8627419612957;863.7063398444434;868.7610907000626;9091.090890910857;9408.858867116998;9914.058164474363;10018.499075046364;10036;581761;583936;596203;605174;609308;132976.68065563485;134423.32788335995;138468.30765846107;138587;142491;984.5372674842812;1017.5421060522795;1018.3380802478597;1065.4406436620836;1072.587053984206;16330.265138069053;18766.249350025846;18900.52748681239;19238.23047078101;19826.206951721768;43452.78273608612;53018.46981530135;53204.40386788402;55794.605134871956;57043.71478142583;72445.63777181291;73190;73719;73927;73978.63010684912;8061.596920154087;8199.688049911985;8389.95805020971;8440.113788052166;8485.448445851;11378.54485820558;13078.215307081606;13086.803697944348;13387;13601.523946661819;11392.373419462008;11453.19827612059;11761.176717629683;11951.043916486835;11974.880251197377;11179.987602231677;11305.830412543653;11426.48580813882;11859.940700296444;11923.701907452383;10331.01855323743;10449.589305443667;11359.602413915472;11581.073514118681;11969.341686206993;7477.813054673677;8179.83640327202;8443.746687599381;8450.366222533457;8522.105178956368;5358.383785864676;7978.800529986796;8842.381033327605;11169.38568378747;11537.365444900612 16:35:39 INFO - PROCESS | 6453 | |3;mootools.html;1321.6431563477868;1483.5771805035563;1505.2699440771228;1687.3082036365086;1864.7948725640176;7884.881726774096;8438;8694.956525217372;8947.239484643813;8954.37319387643;8782.341324400664;8813.118688131184;8878.600462979166;8882.777930551723;8883.156100170474;2274.442761523429;2300.52839167971;2300.9539809203807;2302;2302.102180149743;2375.1686909581595;2394.2338451695464;2421.4914867877765;2421.539907417585;2423.6001059825107;2379.286214135761;2400.843945143569;2407.67496387988;2407.9398015049587;2419.4798118404537;2350.083467447697;2369.5971684813535;2379.5835728747575;2385.558671645751;2400.603900356439;2341.0986770093637;2366;2376.7979721723673;2381;2381.9642705359433;7684.731034413825;8720.651173953034;8905.109489051043;8973.192412682889;8978.191962723386;5232.555232805216;5450.672959622435;5451.754671039773;5500.559955203614;5514.310711161105;3679.337719210541;3703.962960370389;3774.6036666150208;3780.4140358244517;3791.374423220165;1107.0479387726548;1109.6338208391292;1113.7382715061954;1127.2503784982976;1133.3596517967321;11744.941275293655;11798.056155507538;11865.466054027504;11865.762684746343;11894;4082.591740825894;4512.571305725951;4614.684814827758;4649.86050418488;4708.835190768306;9192.448453092837;9259.074092590687;9260.722178334661;9261.861072083924;9276.907230927603;5242.292290540804;5254.15933450646;5256.973715131477;5265.763040663102;5276.736163191825;4211.599898009684;4461.754603496774;4604.309353596987;4606.98646297814;4906.730129842893;3796.6583007529457;3844.2695887781233;3885.747426417274;3926.7447615904875;3936.389859571771;1178.4873579992732;1186.967338415584;1192.3918801411344;1197.6287350921243;1197.7185361440054;769.1846642558905;857.3141486810526;908.2280061947292;918.3755046568264;934.3552948465673;5037.0681423936685;5165;5578.330600327987;5652.067408877571;5922.585419020627;835.2441040858033;877.7630039889194;897.1432282170512;965.8792650918635;969.6848524229654;3357.8321083945707;3714.832832522489;3803.6196380361744;3822.980885095557;3823.502944617182;10633.574657013787;11099.667009989713;11110.388928609003;11121.666350009513;11136.276142050903;11055.00504954558;11057.668269951915;11058.11535077192;11059.834102488468;11065.280756750786;7855.13593504714;8345.499270043816;8486.787830304169;8495.95752021236;8496.787580310542;4953.801847926043;5313.468653134811;5872.442117998783;5955.076963070731;6067.150598916067;10043.146332561813;10057.949710251401;10160.593576256866;10320.071193592612;10337.37975721429;9349.345545812;9878.209743220668;10290.279680422298;10304.742381440225;10459.738506537398;7073.2219455858785;7297.781066568012;7304.561726296439;7306.853862922818;7338.70645174187;7124.964375178091;8167.877481837659;8232.876506852523;8446.957765211135;8570.528620925908;7598.886016709644;7623.504472209289;7626.389888808771;7643.656035478306;7680.308772210527;6496.9025464617125;7395.445341599294;7427.997220375396;7484.401247900046;7538.133114691661;7020.403265722471;7145.963835243757;7146.213916469081;7149.9285007149265;7150.570965742072;4821.373221481185;4878.634102442402;4890.095332363524;4990.850274491771;5116.386033675983;4096.9795151024055;4985.451600324034;5034.496550344937;5106.234064890296;5115.079285728456 16:35:39 INFO - PROCESS | 6453 | |4;prototype.html;290.19760362597407;293.16009632403166;296.7181177881014;300.5476757479992;306.4376868446401;5309.389420216677;5347.465253474656;5389.78440862365;5480.588955828314;5484.122540393538;3992.5608183099835;4986.326845875806;5168.896622067557;5192.662476938996;5225.111731005729;3216.388886111631;3349.4640857462873;4014.337634290353;4023.537293211289;4032.7580345179385;3954.268460334847;4025.6175663311938;4051.270771261172;4098.4671992640915;4128.195001974616;3212.9196770080703;3655.8903232903053;4006.919861602766;4012.538558065831;4043.7169398141996;3858.2862170498547;3999.24014437256;4039.77812203287;4075.6331930126285;4101.0772576170275;3480.460528618043;3488.180277634779;3515.927642069168;3533.2580158166816;3574.7140228781896;4690.906181876378;4881.072596206709;5028.924566131511;5059.991867170313;5160.9872149861585;4515.683902126852;4655.580997710223;4678.7426691531955;4693;4721.474011403917;5475.534579560742;5538.47384498472;5590.440955904418;5595.888082238333;5606.635568688063;3381.2223188666744;3919.862804801847;3926.803659817026;3931.783751893645;3979.820908059144;4903.01939612079;5027.321311622921;5556.816947847433;5818.796342128047;5878.265216847894;3973.106051138471;3979.8408063677707;4001.5398229204015;4002.399640054015;4011.9799401003393;3598.7660802047785;3892.026993251687;4089.4070359798257;4090.3617166927165;4110.34234522475;3973.006748312922;4278.529361770203;4671.95328046722;4707.411573553306;4729.2906064089975;4681.765911704401;4880.804767809248;5015.84952451427;5131.61512886535;5179.171332586768;1301.5357722562117;1330.5941687785319;1352.8308961379828;1353.377446374659;1360.6802401435655;759.3583422008394;772.8454309138083;866.7096522664851;871.1941454154882;905.7373361725158;5353.57171426285;5404.675719456845;5408.215808707715;5424.62027658068;5440.401555828856;5378.2739330189925;5824.650520968756;5881.941180588139;5885.205497257901;5903.704814759245;4591.655625828076;5247.658902171346;5264.263003179558;5318.472603011841;5339.919901201485;2572.2154742803623;2636.709961904189;2841.4459180460026;2887.953209364099;3013.352129292213;5065.924011139762;5477.917831232535;5522.972385138049;5867.119932010147;5977.491913187341;5448.687529658551;5718.485336319751;5769.442140708793;5832.88334233313;5903.970480147657;5277.788888444419;5985.581009329392;5999.640021598718;6000.549958753111;6002.729877155539;5379.273798037371;5430.40265570779;5787.421257874179;5790.276215473066;5890.2342695449315;4863;5783.831063351243;5797.753483001175;5804.593678442638;5856.3558008618165;5071.746412679425;5782.710864456844;6068.969655151873;6073.696315184311;6081.209442772411;3837.2755343705167;3928.9607103928593;3929.54810196831;3937.625925537184;3938.7439816411843;5784.537237021113;5812.273465816773;5858.765649373977;5954.523638109027;5980.611260268069;5562.360328562268;5784.2769653793275;5820.941790582209;5821.912671310019;5828.854278643068;4841.830535931225;4993.975030124826;5643.7742490299925;5728.598998070095;5748.54011679073;4474;4701.412323459567;4972.483392565302;5510.862228444321;5578.442155784389;4681.57212050328;4738.962246234152;5240.2663627093;5489.890202195854;5568.888622227614;5529.751161197836;5588.441155884379;5605.467480589501;5605.635633683797;5614.29821272341 16:35:39 INFO - PROCESS | 6453 | |5;yui.html;714.3285311806904;751.9135299440566;759.9354054905331;770.5646309834939;780.4302858912994;13433.328333583331;15251.389944402225;15923.442679506219;16197.352105915748;16279.59301017475;14309.284535773222;14427.350769215383;14448.5665430037;14457.132572045684;14467.78298325526;677.5968298862169;700.1388292400351;700.3066963705945;821.954792486413;836.6067948064415;854.3122786157141;857.0401150711212;867.6312567158964;867.7049803066956;870.9869351959726;923.1368670293264;924.7087167542236;925.3522534226069;925.694520808135;926.7683079230193;711.3384552366298;735.577043200162;919.3977944446399;921.1985572551889;922.4972390047441;535.237286866214;540.2760301196377;542.2814770429158;644.4908522267403;667.2526770017563;14720.263986800617;14764.26178691061;14778.556643300719;14810.777838332433;14824.184669843155;13492.190468571818;13783.173009619455;13793.517226897111;13801.51694690681;13878.167309961435;10669.306495077795;12027.458764355624;12384.938075309656;12456.065795065315;12475.625731228078;3932.58707835676;4433.8448154314765;4579.244424669925;4659.324397962277;4688.859334219979;112203;114157;120041;120364.39817800942;120894.39552802268;10788.892111078945;10824.837627435594;10935.316207007938;10936.45317734126;10972.890271097187;21431.142754289966;21536.246231381825;21541.56916861654;21585.920703964737;21611.567768644538;7562.395008399315;7598.772036838904;7682.577458239851;8101.878471822927;8115.3913456491;4341.066670665822;4393.934090988638;4466.397036400044;4477.462704475483;4562.247229207143;3465.9826700866333;3507.2459421224557;3537.1864471171775;3552.6447355264268;3556.110972256936;636.3350298937621;644.674439408096;660.2736989311719;663.8937769956784;672.7847088931495;510.91569890968316;607.2864384348374;612.3978303052476;635.4013569084993;648.0959062108333;8396.832063358699;8663.48019118855;8873.378863479624;8948.776280593038;9122.31582631292;611;620.5035971223003;639.0829160155192;640.7545780621232;643.5591619740493;4246.363045543193;4328.458942632171;4342.804573794187;4395.736255824597;4437.977810110993;94677;96891.51554242325;97223;109036;145522.2723886374;130118;133557;134146;134499;145095;93547;97301;110784;113193;115584.8441515591;7362.595057271901;8275.131111233475;8407.873881891654;8409.285210757154;8473.618687159216;61670.69164654148;62661.37338626556;62837.05744413746;63932.680336598016;64111;88519.22961540862;89475.10524894929;93907;97471;101834.49082754539;10974.780504390028;10997.725056873642;11125.721856953318;11739.765204696028;12102.213356131822;12472.5010999559;12616.17994830333;12772.87227127754;13085.803712944504;13449.193048417126;12087.75824483523;12515.311657858541;12534;13979.930100349433;14216.147031178163;11441.76885507318;13391.531296404579;13629.931850340685;13658.065447593603;14548.981571289909;13352.799708004193;13828.723425531634;14081.577552673436;14557;14570.635734106732;11211.71970700739;11570.88429115698;11920.105992050805;11993.460294286953;12114.091443141975;10113.393196408239;11259.268147570381;11593.88406115928;11743.060555155738;11920.22518536327 16:35:39 INFO - PROCESS | 6453 | __end_tp_report 16:35:39 INFO - PROCESS | 6453 | __start_cc_report 16:35:39 INFO - PROCESS | 6453 | _x_x_mozilla_cycle_collect,1591 16:35:39 INFO - PROCESS | 6453 | __end_cc_report 16:35:39 INFO - PROCESS | 6453 | __startTimestamp1478388939277__endTimestamp 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | ------- Summary: start ------- 16:35:39 INFO - PROCESS | 6453 | Number of tests: 6 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | [#0] dojo.html Cycles:165 Average:5746.87 Median:6047.06 stddev:657.35 (10.9%) stddev-sans-first:630.75 16:35:39 INFO - PROCESS | 6453 | Values: 3301.3 3304.7 3318.8 3330.0 3364.5 5671.8 5719.6 5757.1 5778.6 5823.9 5662.8 5744.5 5756.8 5760.7 5777.5 5206.9 5223.9 5241.6 5247.2 5275.9 5191.8 5217.2 5308.9 5329.5 5337.5 5227.3 5242.1 5262.9 5272.4 5283.3 5248.1 5279.2 5280.4 5310.6 5340.8 5188.6 5237.9 5244.5 5282.7 5290.2 4766.5 5527.2 5603.3 5603.7 5604.6 6174.0 6209.3 6214.3 6231.0 6232.3 6214.9 6238.1 6255.8 6276.1 6380.1 5018.6 5736.4 5737.1 5741.9 5781.5 6178.3 6190.7 6254.6 6259.2 6285.1 6209.3 6213.2 6217.4 6218.8 6219.7 6086.5 6141.8 6175.2 6261.0 6275.9 6140.9 6149.0 6162.5 6220.0 6238.7 5625.7 6239.9 6286.8 6292.2 6325.1 4736.9 4877.6 4949.4 4963.7 4971.3 3802.3 4387.3 4420.0 4437.0 4445.5 5853.9 5865.9 5873.2 5874.5 5896.7 6226.3 6245.8 6264.4 6269.2 6271.3 5590.9 5718.5 5729.5 5831.5 5896.5 5335.7 5343.2 5385.3 5390.1 5400.6 6251.6 6263.0 6269.5 6272.5 6280.6 6144.1 6254.2 6273.3 6277.4 6286.7 6199.1 6257.9 6263.8 6268.6 6271.9 6194.5 6258.7 6267.2 6291.6 6292.2 6161.8 6184.1 6250.5 6251.0 6276.3 6000.3 6047.1 6074.3 6092.3 6171.6 5386.9 6113.5 6156.7 6197.7 6198.8 6040.5 6047.2 6057.9 6066.4 6077.4 6041.3 6083.4 6138.8 6140.1 6214.1 5968.7 6043.7 6060.3 6114.1 6126.0 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | [#1] ext.html Cycles:180 Average:68804.77 Median:34728.04 stddev:159570.84 (459.5%) stddev-sans-first:159935.98 16:35:39 INFO - PROCESS | 6453 | Values: 464.5 475.4 492.9 512.4 513.3 29893.4 39298.0 40449.4 40454.2 43276.4 42317.6 42697.8 42699.6 42771.6 43050.0 9701.9 9878.1 9889.3 9889.7 9891.7 8713.5 9001.8 11867.0 12121.9 12129.9 11999.4 12081.6 12089.9 12097.9 12098.7 8849.0 12107.3 12179.6 12204.3 12219.3 8768.5 11676.4 12029.9 12030.6 12241.7 40286.4 40730.8 40760.0 40801.6 41039.0 3340.3 3398.4 3410.2 3425.6 3520.9 29922.0 31233.0 31305.0 31510.0 32010.2 2881.1 3253.8 3255.4 3292.0 3384.7 521927.0 523157.0 523510.4 523604.0 523693.0 32520.0 32815.7 33077.5 34923.0 55943.0 35321.5 35392.6 35395.5 35411.5 35425.1 14964.4 14986.0 14988.9 15061.8 15115.0 11512.7 11855.2 12856.4 12889.7 12975.0 7555.2 7745.4 7755.3 7802.5 7922.1 3170.7 3241.6 3245.6 3273.2 3276.3 862.4 985.5 1019.6 1042.1 1095.8 29840.0 29869.9 30141.0 30281.8 30537.1 967.0 1072.0 1072.3 1087.8 1116.7 14970.4 15310.7 15315.8 15606.8 15691.7 745217.0 750280.0 751598.0 753497.0 753925.0 33469.0 33609.5 40595.0 40673.6 40684.8 1229.8 1256.9 1261.4 1347.5 1366.3 29006.6 30314.4 30422.4 30585.9 30701.8 46970.5 47219.8 47434.0 47564.0 47647.8 411656.0 482111.0 482433.0 482578.6 482816.0 25771.7 26548.7 26903.1 27281.2 27588.7 38680.0 38808.8 44706.3 45542.8 47205.5 37007.0 37431.4 37935.6 39042.6 39247.2 37183.4 38057.2 38580.6 39326.0 39601.6 36473.5 37098.6 37607.6 37828.0 38249.4 31571.4 34213.0 34533.1 35466.8 35981.8 21590.0 23139.2 25614.7 25637.7 25850.9 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | [#2] jquery.html Cycles:180 Average:34485.65 Median:1505.22 stddev:99662.73 (6621.1%) stddev-sans-first:99909.35 16:35:39 INFO - PROCESS | 6453 | Values: 352.7 372.3 375.4 383.4 402.5 14911.8 15177.4 16511.3 20021.0 20631.7 18841.3 19393.3 19774.0 20044.5 20261.8 5827.7 5842.7 5937.3 5940.0 6096.9 5879.1 5942.8 6010.5 6011.8 6014.2 5685.3 5879.6 5954.3 5975.2 5985.7 5920.9 5958.4 5965.2 5968.5 5969.6 4245.3 5199.0 5204.5 5546.4 5574.7 13205.9 13218.1 13297.7 13439.3 13470.5 2071.3 2198.8 2248.4 2641.9 2657.8 9965.3 10129.6 12392.8 13734.7 15497.7 1824.9 1843.4 1861.2 1915.5 1944.3 115699.0 116167.4 116230.0 116998.4 118051.4 8944.2 11059.3 11436.9 11694.7 11832.9 11886.8 12354.9 14722.4 14727.0 14732.0 7474.5 8039.2 8201.0 8338.7 8352.2 8652.0 8658.6 8694.8 8785.6 8823.3 3835.3 3928.9 3953.4 3973.6 3979.3 1907.6 1957.9 1959.1 1959.3 1959.6 740.2 793.8 809.4 813.1 831.1 18209.5 18378.1 18984.4 19017.8 19269.4 833.3 846.8 857.9 863.7 868.8 9091.1 9408.9 9914.1 10018.5 10036.0 581761.0 583936.0 596203.0 605174.0 609308.0 132976.7 134423.3 138468.3 138587.0 142491.0 984.5 1017.5 1018.3 1065.4 1072.6 16330.3 18766.2 18900.5 19238.2 19826.2 43452.8 53018.5 53204.4 55794.6 57043.7 72445.6 73190.0 73719.0 73927.0 73978.6 8061.6 8199.7 8390.0 8440.1 8485.4 11378.5 13078.2 13086.8 13387.0 13601.5 11392.4 11453.2 11761.2 11951.0 11974.9 11180.0 11305.8 11426.5 11859.9 11923.7 10331.0 10449.6 11359.6 11581.1 11969.3 7477.8 8179.8 8443.7 8450.4 8522.1 5358.4 7978.8 8842.4 11169.4 11537.4 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | [#3] mootools.html Cycles:180 Average:5687.32 Median:4898.41 stddev:3231.66 (66.0%) stddev-sans-first:3224.07 16:35:39 INFO - PROCESS | 6453 | Values: 1321.6 1483.6 1505.3 1687.3 1864.8 7884.9 8438.0 8695.0 8947.2 8954.4 8782.3 8813.1 8878.6 8882.8 8883.2 2274.4 2300.5 2301.0 2302.0 2302.1 2375.2 2394.2 2421.5 2421.5 2423.6 2379.3 2400.8 2407.7 2407.9 2419.5 2350.1 2369.6 2379.6 2385.6 2400.6 2341.1 2366.0 2376.8 2381.0 2382.0 7684.7 8720.7 8905.1 8973.2 8978.2 5232.6 5450.7 5451.8 5500.6 5514.3 3679.3 3704.0 3774.6 3780.4 3791.4 1107.0 1109.6 1113.7 1127.3 1133.4 11744.9 11798.1 11865.5 11865.8 11894.0 4082.6 4512.6 4614.7 4649.9 4708.8 9192.4 9259.1 9260.7 9261.9 9276.9 5242.3 5254.2 5257.0 5265.8 5276.7 4211.6 4461.8 4604.3 4607.0 4906.7 3796.7 3844.3 3885.7 3926.7 3936.4 1178.5 1187.0 1192.4 1197.6 1197.7 769.2 857.3 908.2 918.4 934.4 5037.1 5165.0 5578.3 5652.1 5922.6 835.2 877.8 897.1 965.9 969.7 3357.8 3714.8 3803.6 3823.0 3823.5 10633.6 11099.7 11110.4 11121.7 11136.3 11055.0 11057.7 11058.1 11059.8 11065.3 7855.1 8345.5 8486.8 8496.0 8496.8 4953.8 5313.5 5872.4 5955.1 6067.2 10043.1 10057.9 10160.6 10320.1 10337.4 9349.3 9878.2 10290.3 10304.7 10459.7 7073.2 7297.8 7304.6 7306.9 7338.7 7125.0 8167.9 8232.9 8447.0 8570.5 7598.9 7623.5 7626.4 7643.7 7680.3 6496.9 7395.4 7428.0 7484.4 7538.1 7020.4 7146.0 7146.2 7149.9 7150.6 4821.4 4878.6 4890.1 4990.9 5116.4 4097.0 4985.5 5034.5 5106.2 5115.1 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | [#4] prototype.html Cycles:180 Average:4551.21 Median:5068.84 stddev:1410.35 (27.8%) stddev-sans-first:1377.57 16:35:39 INFO - PROCESS | 6453 | Values: 290.2 293.2 296.7 300.5 306.4 5309.4 5347.5 5389.8 5480.6 5484.1 3992.6 4986.3 5168.9 5192.7 5225.1 3216.4 3349.5 4014.3 4023.5 4032.8 3954.3 4025.6 4051.3 4098.5 4128.2 3212.9 3655.9 4006.9 4012.5 4043.7 3858.3 3999.2 4039.8 4075.6 4101.1 3480.5 3488.2 3515.9 3533.3 3574.7 4690.9 4881.1 5028.9 5060.0 5161.0 4515.7 4655.6 4678.7 4693.0 4721.5 5475.5 5538.5 5590.4 5595.9 5606.6 3381.2 3919.9 3926.8 3931.8 3979.8 4903.0 5027.3 5556.8 5818.8 5878.3 3973.1 3979.8 4001.5 4002.4 4012.0 3598.8 3892.0 4089.4 4090.4 4110.3 3973.0 4278.5 4672.0 4707.4 4729.3 4681.8 4880.8 5015.8 5131.6 5179.2 1301.5 1330.6 1352.8 1353.4 1360.7 759.4 772.8 866.7 871.2 905.7 5353.6 5404.7 5408.2 5424.6 5440.4 5378.3 5824.7 5881.9 5885.2 5903.7 4591.7 5247.7 5264.3 5318.5 5339.9 2572.2 2636.7 2841.4 2888.0 3013.4 5065.9 5477.9 5523.0 5867.1 5977.5 5448.7 5718.5 5769.4 5832.9 5904.0 5277.8 5985.6 5999.6 6000.5 6002.7 5379.3 5430.4 5787.4 5790.3 5890.2 4863.0 5783.8 5797.8 5804.6 5856.4 5071.7 5782.7 6069.0 6073.7 6081.2 3837.3 3929.0 3929.5 3937.6 3938.7 5784.5 5812.3 5858.8 5954.5 5980.6 5562.4 5784.3 5820.9 5821.9 5828.9 4841.8 4994.0 5643.8 5728.6 5748.5 4474.0 4701.4 4972.5 5510.9 5578.4 4681.6 4739.0 5240.3 5489.9 5568.9 5529.8 5588.4 5605.5 5605.6 5614.3 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - PROCESS | 6453 | [#5] yui.html Cycles:180 Average:23996.60 Median:3744.35 stddev:37684.78 (1006.4%) stddev-sans-first:37749.95 16:35:39 INFO - PROCESS | 6453 | Values: 714.3 751.9 759.9 770.6 780.4 13433.3 15251.4 15923.4 16197.4 16279.6 14309.3 14427.4 14448.6 14457.1 14467.8 677.6 700.1 700.3 822.0 836.6 854.3 857.0 867.6 867.7 871.0 923.1 924.7 925.4 925.7 926.8 711.3 735.6 919.4 921.2 922.5 535.2 540.3 542.3 644.5 667.3 14720.3 14764.3 14778.6 14810.8 14824.2 13492.2 13783.2 13793.5 13801.5 13878.2 10669.3 12027.5 12384.9 12456.1 12475.6 3932.6 4433.8 4579.2 4659.3 4688.9 112203.0 114157.0 120041.0 120364.4 120894.4 10788.9 10824.8 10935.3 10936.5 10972.9 21431.1 21536.2 21541.6 21585.9 21611.6 7562.4 7598.8 7682.6 8101.9 8115.4 4341.1 4393.9 4466.4 4477.5 4562.2 3466.0 3507.2 3537.2 3552.6 3556.1 636.3 644.7 660.3 663.9 672.8 510.9 607.3 612.4 635.4 648.1 8396.8 8663.5 8873.4 8948.8 9122.3 611.0 620.5 639.1 640.8 643.6 4246.4 4328.5 4342.8 4395.7 4438.0 94677.0 96891.5 97223.0 109036.0 145522.3 130118.0 133557.0 134146.0 134499.0 145095.0 93547.0 97301.0 110784.0 113193.0 115584.8 7362.6 8275.1 8407.9 8409.3 8473.6 61670.7 62661.4 62837.1 63932.7 64111.0 88519.2 89475.1 93907.0 97471.0 101834.5 10974.8 10997.7 11125.7 11739.8 12102.2 12472.5 12616.2 12772.9 13085.8 13449.2 12087.8 12515.3 12534.0 13979.9 14216.1 11441.8 13391.5 13629.9 13658.1 14549.0 13352.8 13828.7 14081.6 14557.0 14570.6 11211.7 11570.9 11920.1 11993.5 12114.1 10113.4 11259.3 11593.9 11743.1 11920.2 16:35:39 INFO - PROCESS | 6453 | -------- Summary: end -------- 16:35:39 INFO - PROCESS | 6453 | 16:35:39 INFO - TEST-INFO | 6453: exit 0 16:35:39 INFO - TEST-OK | dromaeo_css | took 1118166ms 16:35:39 INFO - TEST-START | kraken 16:35:39 INFO - operating with platform_type : mac_ 16:35:39 INFO - Initialising browser for kraken test... 16:35:39 INFO - TEST-INFO | started process 6456 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpPDXnhy/profile http://localhost:57508/getInfo.html) 16:35:42 INFO - PROCESS | 6456 | __metrics Screen width/height:1600/1200 16:35:42 INFO - PROCESS | 6456 | colorDepth:24 16:35:42 INFO - PROCESS | 6456 | Browser inner width/height: 1024/689 16:35:42 INFO - PROCESS | 6456 | __metrics 16:35:42 INFO - PROCESS | 6456 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:35:42 INFO - PROCESS | 6456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:43 INFO - TEST-INFO | 6456: exit 0 16:35:43 INFO - Browser initialized. 16:35:43 INFO - Running cycle 1/1 for kraken test... 16:35:43 INFO - TEST-INFO | started process 6457 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpPDXnhy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:55 INFO - PROCESS | 6457 | RSS: Main: 219664384 16:35:55 INFO - PROCESS | 6457 | 16:35:57 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57508/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:58 INFO - PROCESS | 6457 | RSS: Main: 270127104 16:35:58 INFO - PROCESS | 6457 | 16:36:01 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57508/tests/kraken/driver.html?testName=audio-dft) 16:36:01 INFO - PROCESS | 6457 | RSS: Main: 280932352 16:36:01 INFO - PROCESS | 6457 | 16:36:05 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57508/tests/kraken/driver.html?testName=audio-fft) 16:36:05 INFO - PROCESS | 6457 | RSS: Main: 377729024 16:36:05 INFO - PROCESS | 6457 | 16:36:07 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57508/tests/kraken/driver.html?testName=audio-oscillator) 16:36:08 INFO - PROCESS | 6457 | RSS: Main: 280576000 16:36:08 INFO - PROCESS | 6457 | 16:36:10 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:10 INFO - PROCESS | 6457 | RSS: Main: 281403392 16:36:10 INFO - PROCESS | 6457 | 16:36:13 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57508/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:14 INFO - PROCESS | 6457 | RSS: Main: 319352832 16:36:14 INFO - PROCESS | 6457 | 16:36:17 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57508/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:17 INFO - PROCESS | 6457 | RSS: Main: 318787584 16:36:17 INFO - PROCESS | 6457 | 16:36:20 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57508/tests/kraken/driver.html?testName=json-parse-financial) 16:36:21 INFO - PROCESS | 6457 | RSS: Main: 317317120 16:36:21 INFO - PROCESS | 6457 | 16:36:22 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:23 INFO - PROCESS | 6457 | RSS: Main: 295559168 16:36:23 INFO - PROCESS | 6457 | 16:36:25 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:25 INFO - PROCESS | 6457 | RSS: Main: 295419904 16:36:25 INFO - PROCESS | 6457 | 16:36:27 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:28 INFO - PROCESS | 6457 | RSS: Main: 303423488 16:36:28 INFO - PROCESS | 6457 | 16:36:31 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:32 INFO - PROCESS | 6457 | RSS: Main: 315654144 16:36:32 INFO - PROCESS | 6457 | 16:36:35 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:35 INFO - PROCESS | 6457 | RSS: Main: 309235712 16:36:35 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | Cycle 1(1): loaded http://localhost:57508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57508/tests/kraken/driver.html?testName=ai-astar) 16:36:37 INFO - PROCESS | 6457 | RSS: Main: 353124352 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | __start_tp_report 16:36:37 INFO - PROCESS | 6457 | _x_x_mozilla_page_load 16:36:37 INFO - PROCESS | 6457 | _x_x_mozilla_page_load_details 16:36:37 INFO - PROCESS | 6457 | |i|pagename|runs| 16:36:37 INFO - PROCESS | 6457 | |0;ai-astar;115;115;116;115;116;116;114;115;117;116 16:36:37 INFO - PROCESS | 6457 | |1;audio-beat-detection;145;111;111;146;121;110;107;106;141;110 16:36:37 INFO - PROCESS | 6457 | |2;audio-dft;185;185;182;186;186;182;186;184;184;185 16:36:37 INFO - PROCESS | 6457 | |3;audio-fft;80;59;59;90;62;61;58;58;83;58 16:36:37 INFO - PROCESS | 6457 | |4;audio-oscillator;84;70;95;72;67;68;93;68;68;90 16:36:37 INFO - PROCESS | 6457 | |5;imaging-gaussian-blur;87;85;88;85;88;83;88;85;91;85 16:36:37 INFO - PROCESS | 6457 | |6;imaging-darkroom;94;95;94;94;94;95;95;95;93;93 16:36:37 INFO - PROCESS | 6457 | |7;imaging-desaturate;84;86;85;87;85;84;83;86;86;86 16:36:37 INFO - PROCESS | 6457 | |8;json-parse-financial;54;52;53;54;58;57;56;56;57;57 16:36:37 INFO - PROCESS | 6457 | |9;json-stringify-tinderbox;74;80;70;74;73;70;70;70;71;73 16:36:37 INFO - PROCESS | 6457 | |10;stanford-crypto-aes;81;83;82;85;80;80;84;85;82;89 16:36:37 INFO - PROCESS | 6457 | |11;stanford-crypto-ccm;141;154;144;139;133;147;156;139;176;152 16:36:37 INFO - PROCESS | 6457 | |12;stanford-crypto-pbkdf2;164;161;162;162;163;169;168;164;165;164 16:36:37 INFO - PROCESS | 6457 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;68;66;68;67;66 16:36:37 INFO - PROCESS | 6457 | __end_tp_report 16:36:37 INFO - PROCESS | 6457 | __start_cc_report 16:36:37 INFO - PROCESS | 6457 | _x_x_mozilla_cycle_collect,2000 16:36:37 INFO - PROCESS | 6457 | __end_cc_report 16:36:37 INFO - PROCESS | 6457 | __startTimestamp1478388997672__endTimestamp 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | ------- Summary: start ------- 16:36:37 INFO - PROCESS | 6457 | Number of tests: 14 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 16:36:37 INFO - PROCESS | 6457 | Values: 115.0 115.0 116.0 115.0 116.0 116.0 114.0 115.0 117.0 116.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:116.00 stddev:16.54 (14.3%) stddev-sans-first:15.05 16:36:37 INFO - PROCESS | 6457 | Values: 145.0 111.0 111.0 146.0 121.0 110.0 107.0 106.0 141.0 110.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.51 (0.8%) stddev-sans-first:1.59 16:36:37 INFO - PROCESS | 6457 | Values: 185.0 185.0 182.0 186.0 186.0 182.0 186.0 184.0 184.0 185.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.50 stddev:12.41 (20.2%) stddev-sans-first:12.21 16:36:37 INFO - PROCESS | 6457 | Values: 80.0 59.0 59.0 90.0 62.0 61.0 58.0 58.0 83.0 58.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:11.61 (14.9%) stddev-sans-first:12.07 16:36:37 INFO - PROCESS | 6457 | Values: 84.0 70.0 95.0 72.0 67.0 68.0 93.0 68.0 68.0 90.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:2.32 (2.7%) stddev-sans-first:2.46 16:36:37 INFO - PROCESS | 6457 | Values: 87.0 85.0 88.0 85.0 88.0 83.0 88.0 85.0 91.0 85.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 16:36:37 INFO - PROCESS | 6457 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 93.0 93.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.23 (1.4%) stddev-sans-first:1.22 16:36:37 INFO - PROCESS | 6457 | Values: 84.0 86.0 85.0 87.0 85.0 84.0 83.0 86.0 86.0 86.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.50 stddev:2.01 (3.6%) stddev-sans-first:2.07 16:36:37 INFO - PROCESS | 6457 | Values: 54.0 52.0 53.0 54.0 58.0 57.0 56.0 56.0 57.0 57.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:73.00 stddev:3.14 (4.3%) stddev-sans-first:3.28 16:36:37 INFO - PROCESS | 6457 | Values: 74.0 80.0 70.0 74.0 73.0 70.0 70.0 70.0 71.0 73.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:2.77 (3.3%) stddev-sans-first:2.83 16:36:37 INFO - PROCESS | 6457 | Values: 81.0 83.0 82.0 85.0 80.0 80.0 84.0 85.0 82.0 89.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:149.50 stddev:12.26 (8.2%) stddev-sans-first:12.73 16:36:37 INFO - PROCESS | 6457 | Values: 141.0 154.0 144.0 139.0 133.0 147.0 156.0 139.0 176.0 152.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:2.57 (1.6%) stddev-sans-first:2.73 16:36:37 INFO - PROCESS | 6457 | Values: 164.0 161.0 162.0 162.0 163.0 169.0 168.0 164.0 165.0 164.0 16:36:37 INFO - PROCESS | 6457 | 16:36:37 INFO - PROCESS | 6457 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 16:36:37 INFO - PROCESS | 6457 | Values: 67.0 68.0 67.0 68.0 67.0 68.0 66.0 68.0 67.0 66.0 16:36:37 INFO - PROCESS | 6457 | -------- Summary: end -------- 16:36:37 INFO - PROCESS | 6457 | 16:36:38 INFO - TEST-INFO | 6457: exit 0 16:36:38 INFO - TEST-OK | kraken | took 58619ms 16:36:38 INFO - SUITE-END | took 1176s 16:36:38 INFO - Completed test suite (00:19:37) 16:36:38 INFO - javascript benchmark 16:36:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.2902226021406, 3304.7190988765947, 3318.800871947682, 3330.0, 3364.495325701146, 5671.8298451046485, 5719.571032172583, 5757.050086735689, 5778.566607504444, 5823.854403639911, 5662.773489060432, 5744.511716504092, 5756.769729210837, 5760.7407666655, 5777.480026797587, 5206.895862082756, 5223.947760522384, 5241.606879484035, 5247.239150323191, 5275.894482110355, 5191.818286359978, 5217.217417387404, 5308.938212357524, 5329.546988505962, 5337.5196232339085, 5227.320448341729, 5242.082635538784, 5262.894742105155, 5272.367315922094, 5283.260343551887, 5248.0815857225025, 5279.208118782213, 5280.392754833205, 5310.62825602208, 5340.813071542516, 5188.5849132069725, 5237.869053273661, 5244.475552444763, 5282.735863206863, 5290.206469029677, 4766.52334766524, 5527.226188333637, 5603.271574695264, 5603.7478313475995, 5604.635698679614, 6173.969130154321, 6209.285932117819, 6214.316425193225, 6231.0, 6232.3144454110015, 6214.906776398358, 6238.095476155932, 6255.812325630239, 6276.121343011982, 6380.106785050097, 5018.573421259161, 5736.368999410061, 5737.053386191274, 5741.88516229673, 5781.53747700183, 6178.289496707936, 6190.659513726789, 6254.562180647402, 6259.248890133122, 6285.088662143963, 6209.316975132731, 6213.161223234896, 6217.440430361289, 6218.782342617987, 6219.720112594944, 6086.513078953673, 6141.846453838601, 6175.197224360894, 6261.0, 6275.874482510324, 6140.8771824564155, 6149.0, 6162.5378096642935, 6219.968900155561, 6238.65687387189, 5625.690587017753, 6239.937600624026, 6286.842828929313, 6292.182016337847, 6325.082862984841, 4736.905261894743, 4877.6341774367065, 4949.3611639463525, 4963.70217786934, 4971.279164521125, 3802.2585595809105, 4387.341898715218, 4420.049689316812, 4437.0460351024685, 4445.533219012022, 5853.912191317134, 5865.853353666107, 5873.177755114288, 5874.50066744323, 5896.734646940898, 6226.283977342573, 6245.75016999324, 6264.373562643699, 6269.185005949197, 6271.27880293763, 5590.888182236414, 5718.51392631631, 5729.512991395694, 5831.475167234885, 5896.528277737771, 5335.706536140472, 5343.225232341289, 5385.299911011622, 5390.137577987503, 5400.648957817729, 6251.593646412968, 6263.0, 6269.498440124779, 6272.529560283088, 6280.560360774702, 6144.139820425234, 6254.186955695731, 6273.341299163522, 6277.372262773686, 6286.748530058747, 6199.1011303359855, 6257.906131408124, 6263.843403914939, 6268.592541484789, 6271.905921411274, 6194.473469755121, 6258.655773932477, 6267.2165979252595, 6291.591046581958, 6292.2134733158355, 6161.784337548164, 6184.072389141665, 6250.468710159687, 6250.9998400255745, 6276.309605943251, 6000.279966404059, 6047.0627052806885, 6074.301455332693, 6092.329843717276, 6171.6297022178815, 5386.946130538645, 6113.480354169946, 6156.661383623944, 6197.690115494297, 6198.783042593668, 6040.516758659384, 6047.153398524122, 6057.909131362945, 6066.363031881765, 6077.392260773887, 6041.2750469943885, 6083.422074902877, 6138.815835524942, 6140.109684095871, 6214.130021796862, 5968.671723055274, 6043.667598282137, 6060.303065147565, 6114.052321890114, 6125.989211780006], "value": 5703.406538728982, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.48442229125664, 475.36301356182713, 492.8841722195286, 512.3518748782791, 513.3147248423354, 29893.402131957377, 39298.0, 40449.39325910114, 40454.19091618166, 43276.350854737204, 42317.57682423175, 42697.7865110674, 42699.57300426995, 42771.57228427715, 43050.0, 9701.854472182906, 9878.110970012698, 9889.307748457612, 9889.703308900744, 9891.653792117277, 8713.520756358397, 9001.819963600725, 11867.0, 12121.878781212206, 12129.878701212963, 11999.40002999851, 12081.577144799934, 12089.879101209008, 12097.879021209807, 12098.697532561713, 8848.955755221246, 12107.273563586168, 12179.573714920023, 12204.267743935303, 12219.327936963418, 8768.517731524764, 11676.416179191092, 12029.93985030078, 12030.578929737418, 12241.69395765113, 40286.39570406446, 40730.796346018375, 40760.0, 40801.59198408008, 41039.0, 3340.28183940454, 3398.371301309241, 3410.2326976430354, 3425.6060553036473, 3520.9295814083575, 29922.0, 31233.0, 31305.0, 31509.951853129704, 32010.199745006328, 2881.121258016304, 3253.837308134584, 3255.3814775192636, 3291.9835400822844, 3384.678455546744, 521927.0, 523157.0, 523510.38244808913, 523604.0, 523692.9999999962, 32520.0, 32815.671843281736, 33077.503837442455, 34922.9523114307, 55943.0, 35321.470177947354, 35392.646073538934, 35395.469067964004, 35411.4688279676, 35425.114372140386, 14964.401423943138, 14986.0, 14988.850111498963, 15061.849381506045, 15115.0, 11512.712182195512, 11855.17013809025, 12856.357182140855, 12889.677758055936, 12975.026872984376, 7555.206703296185, 7745.380369570421, 7755.30202281786, 7802.453828231969, 7922.128565857751, 3170.682931706811, 3241.6434192238835, 3245.6105267368066, 3273.214428537134, 3276.3447310537513, 862.4480332587149, 985.522021819417, 1019.6074511313197, 1042.0517329230363, 1095.8356246562919, 29840.0, 29869.850650746608, 30141.0, 30281.848590756905, 30537.08388748341, 966.9669075844719, 1071.994640026795, 1072.3030030480095, 1087.7878813631423, 1116.7375666718315, 14970.401183952737, 15310.693786124439, 15315.770263446057, 15606.765898511532, 15691.686166276839, 745217.0, 750280.0, 751598.0, 753497.0, 753925.0, 33469.0, 33609.49585756216, 40595.0, 40673.59326406698, 40684.77945661635, 1229.8401207842924, 1256.8617452080264, 1261.4008346035744, 1347.528365072256, 1366.2622184020518, 29006.56490152607, 30314.393712126075, 30422.391552169276, 30585.860193132015, 30701.846490768297, 46970.53029469662, 47219.763901180275, 47434.0, 47564.0, 47647.76176119097, 411656.0, 482111.0, 482433.0, 482578.58710707625, 482816.0, 25771.742282576935, 26548.734512654628, 26903.05839295615, 27281.181564553095, 27588.724112758617, 38680.0, 38808.80595597004, 44706.3294050583, 45542.77228613836, 47205.527944721485, 37007.0, 37431.43852842155, 37935.62064379321, 39042.609573905036, 39247.2150556993, 37183.442248365754, 38057.238855223295, 38580.614193857706, 39326.0, 39601.603983959794, 36473.452898206015, 37098.6290137106, 37607.62392376041, 37828.0, 38249.4262586067, 31571.36857262888, 34213.0, 34533.13667158341, 35466.78064490449, 35981.820090899375, 21590.00822675978, 23139.190128345428, 25614.74385256198, 25637.743622563536, 25850.870745646906], "value": 18485.566995693123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.66144501278774, 372.270350113777, 375.44621683017544, 383.40189304684696, 402.5451240098688, 14911.776323355158, 15177.39290428383, 16511.266317036705, 20021.0, 20631.69052464214, 18841.340553080645, 19393.321233756822, 19774.011299435006, 20044.498887527818, 20261.797382026176, 5827.71790206155, 5842.678652674102, 5937.2578427696535, 5939.960506911273, 6096.908546371808, 5879.11813228017, 5942.821715348547, 6010.549208809335, 6011.819645410645, 6014.248218972629, 5685.317761868581, 5879.588428809985, 5954.345022047572, 5975.223220981288, 5985.700714964234, 5920.851978700523, 5958.433948774859, 5965.22452081231, 5968.46283834457, 5969.552283578749, 4245.341971994346, 5199.0, 5204.531592156724, 5546.389897111315, 5574.749136288877, 13205.86794132056, 13218.07473476857, 13297.734045319135, 13439.328033598282, 13470.461181552726, 2071.295759441797, 2198.8131008864266, 2248.4041728941843, 2641.947161056768, 2657.7873770098345, 9965.302428829984, 10129.594816207344, 12392.81410778839, 13734.725305493934, 15497.690046199014, 1824.9361272355536, 1843.419322913278, 1861.2275905499203, 1915.5019694879431, 1944.2903340280695, 115699.0, 116167.4191629045, 116230.0, 116998.41500792441, 118051.40974295074, 8944.195022448012, 11059.281146725438, 11436.913493218131, 11694.70763230926, 11832.88167118335, 11886.762264754656, 12354.876451235372, 14722.411103555738, 14727.0, 14732.042417242845, 7474.514156579914, 8039.196080391914, 8200.958995204986, 8338.749837504885, 8352.164783521599, 8652.04827468978, 8658.610362533702, 8694.782630434163, 8785.604647790864, 8823.338249631302, 3835.271298453285, 3928.9017774555864, 3953.367461206251, 3973.5827738087664, 3979.3036218662196, 1907.637548865711, 1957.9314723984878, 1959.1477707197414, 1959.2554829164826, 1959.6080783843004, 740.2338579570227, 793.773774474272, 809.380823669893, 813.0527934955828, 831.1439217605875, 18209.45371638853, 18378.08109594515, 18984.43046708601, 19017.809821901603, 19269.4219173425, 833.2833762963846, 846.7713717296418, 857.8627419612957, 863.7063398444434, 868.7610907000626, 9091.090890910857, 9408.858867116998, 9914.058164474363, 10018.499075046364, 10036.0, 581761.0, 583936.0, 596203.0, 605174.0, 609308.0, 132976.68065563485, 134423.32788335995, 138468.30765846107, 138587.0, 142491.0, 984.5372674842812, 1017.5421060522795, 1018.3380802478597, 1065.4406436620836, 1072.587053984206, 16330.265138069053, 18766.249350025846, 18900.52748681239, 19238.23047078101, 19826.206951721768, 43452.78273608612, 53018.46981530135, 53204.40386788402, 55794.605134871956, 57043.71478142583, 72445.63777181291, 73190.0, 73719.0, 73927.0, 73978.63010684912, 8061.596920154087, 8199.688049911985, 8389.95805020971, 8440.113788052166, 8485.448445851, 11378.54485820558, 13078.215307081606, 13086.803697944348, 13387.0, 13601.523946661819, 11392.373419462008, 11453.19827612059, 11761.176717629683, 11951.043916486835, 11974.880251197377, 11179.987602231677, 11305.830412543653, 11426.48580813882, 11859.940700296444, 11923.701907452383, 10331.01855323743, 10449.589305443667, 11359.602413915472, 11581.073514118681, 11969.341686206993, 7477.813054673677, 8179.83640327202, 8443.746687599381, 8450.366222533457, 8522.105178956368, 5358.383785864676, 7978.800529986796, 8842.381033327605, 11169.38568378747, 11537.365444900612], "value": 9209.932287361295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.6431563477868, 1483.5771805035563, 1505.2699440771228, 1687.3082036365086, 1864.7948725640176, 7884.881726774096, 8438.0, 8694.956525217372, 8947.239484643813, 8954.37319387643, 8782.341324400664, 8813.118688131184, 8878.600462979166, 8882.777930551723, 8883.156100170474, 2274.442761523429, 2300.52839167971, 2300.9539809203807, 2302.0, 2302.102180149743, 2375.1686909581595, 2394.2338451695464, 2421.4914867877765, 2421.539907417585, 2423.6001059825107, 2379.286214135761, 2400.843945143569, 2407.67496387988, 2407.9398015049587, 2419.4798118404537, 2350.083467447697, 2369.5971684813535, 2379.5835728747575, 2385.558671645751, 2400.603900356439, 2341.0986770093637, 2366.0, 2376.7979721723673, 2381.0, 2381.9642705359433, 7684.731034413825, 8720.651173953034, 8905.109489051043, 8973.192412682889, 8978.191962723386, 5232.555232805216, 5450.672959622435, 5451.754671039773, 5500.559955203614, 5514.310711161105, 3679.337719210541, 3703.962960370389, 3774.6036666150208, 3780.4140358244517, 3791.374423220165, 1107.0479387726548, 1109.6338208391292, 1113.7382715061954, 1127.2503784982976, 1133.3596517967321, 11744.941275293655, 11798.056155507538, 11865.466054027504, 11865.762684746343, 11894.0, 4082.591740825894, 4512.571305725951, 4614.684814827758, 4649.86050418488, 4708.835190768306, 9192.448453092837, 9259.074092590687, 9260.722178334661, 9261.861072083924, 9276.907230927603, 5242.292290540804, 5254.15933450646, 5256.973715131477, 5265.763040663102, 5276.736163191825, 4211.599898009684, 4461.754603496774, 4604.309353596987, 4606.98646297814, 4906.730129842893, 3796.6583007529457, 3844.2695887781233, 3885.747426417274, 3926.7447615904875, 3936.389859571771, 1178.4873579992732, 1186.967338415584, 1192.3918801411344, 1197.6287350921243, 1197.7185361440054, 769.1846642558905, 857.3141486810526, 908.2280061947292, 918.3755046568264, 934.3552948465673, 5037.0681423936685, 5165.0, 5578.330600327987, 5652.067408877571, 5922.585419020627, 835.2441040858033, 877.7630039889194, 897.1432282170512, 965.8792650918635, 969.6848524229654, 3357.8321083945707, 3714.832832522489, 3803.6196380361744, 3822.980885095557, 3823.502944617182, 10633.574657013787, 11099.667009989713, 11110.388928609003, 11121.666350009513, 11136.276142050903, 11055.00504954558, 11057.668269951915, 11058.11535077192, 11059.834102488468, 11065.280756750786, 7855.13593504714, 8345.499270043816, 8486.787830304169, 8495.95752021236, 8496.787580310542, 4953.801847926043, 5313.468653134811, 5872.442117998783, 5955.076963070731, 6067.150598916067, 10043.146332561813, 10057.949710251401, 10160.593576256866, 10320.071193592612, 10337.37975721429, 9349.345545812, 9878.209743220668, 10290.279680422298, 10304.742381440225, 10459.738506537398, 7073.2219455858785, 7297.781066568012, 7304.561726296439, 7306.853862922818, 7338.70645174187, 7124.964375178091, 8167.877481837659, 8232.876506852523, 8446.957765211135, 8570.528620925908, 7598.886016709644, 7623.504472209289, 7626.389888808771, 7643.656035478306, 7680.308772210527, 6496.9025464617125, 7395.445341599294, 7427.997220375396, 7484.401247900046, 7538.133114691661, 7020.403265722471, 7145.963835243757, 7146.213916469081, 7149.9285007149265, 7150.570965742072, 4821.373221481185, 4878.634102442402, 4890.095332363524, 4990.850274491771, 5116.386033675983, 4096.9795151024055, 4985.451600324034, 5034.496550344937, 5106.234064890296, 5115.079285728456], "value": 4555.9507824785105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.19760362597407, 293.16009632403166, 296.7181177881014, 300.5476757479992, 306.4376868446401, 5309.389420216677, 5347.465253474656, 5389.78440862365, 5480.588955828314, 5484.122540393538, 3992.5608183099835, 4986.326845875806, 5168.896622067557, 5192.662476938996, 5225.111731005729, 3216.388886111631, 3349.4640857462873, 4014.337634290353, 4023.537293211289, 4032.7580345179385, 3954.268460334847, 4025.6175663311938, 4051.270771261172, 4098.4671992640915, 4128.195001974616, 3212.9196770080703, 3655.8903232903053, 4006.919861602766, 4012.538558065831, 4043.7169398141996, 3858.2862170498547, 3999.24014437256, 4039.77812203287, 4075.6331930126285, 4101.0772576170275, 3480.460528618043, 3488.180277634779, 3515.927642069168, 3533.2580158166816, 3574.7140228781896, 4690.906181876378, 4881.072596206709, 5028.924566131511, 5059.991867170313, 5160.9872149861585, 4515.683902126852, 4655.580997710223, 4678.7426691531955, 4693.0, 4721.474011403917, 5475.534579560742, 5538.47384498472, 5590.440955904418, 5595.888082238333, 5606.635568688063, 3381.2223188666744, 3919.862804801847, 3926.803659817026, 3931.783751893645, 3979.820908059144, 4903.01939612079, 5027.321311622921, 5556.816947847433, 5818.796342128047, 5878.265216847894, 3973.106051138471, 3979.8408063677707, 4001.5398229204015, 4002.399640054015, 4011.9799401003393, 3598.7660802047785, 3892.026993251687, 4089.4070359798257, 4090.3617166927165, 4110.34234522475, 3973.006748312922, 4278.529361770203, 4671.95328046722, 4707.411573553306, 4729.2906064089975, 4681.765911704401, 4880.804767809248, 5015.84952451427, 5131.61512886535, 5179.171332586768, 1301.5357722562117, 1330.5941687785319, 1352.8308961379828, 1353.377446374659, 1360.6802401435655, 759.3583422008394, 772.8454309138083, 866.7096522664851, 871.1941454154882, 905.7373361725158, 5353.57171426285, 5404.675719456845, 5408.215808707715, 5424.62027658068, 5440.401555828856, 5378.2739330189925, 5824.650520968756, 5881.941180588139, 5885.205497257901, 5903.704814759245, 4591.655625828076, 5247.658902171346, 5264.263003179558, 5318.472603011841, 5339.919901201485, 2572.2154742803623, 2636.709961904189, 2841.4459180460026, 2887.953209364099, 3013.352129292213, 5065.924011139762, 5477.917831232535, 5522.972385138049, 5867.119932010147, 5977.491913187341, 5448.687529658551, 5718.485336319751, 5769.442140708793, 5832.88334233313, 5903.970480147657, 5277.788888444419, 5985.581009329392, 5999.640021598718, 6000.549958753111, 6002.729877155539, 5379.273798037371, 5430.40265570779, 5787.421257874179, 5790.276215473066, 5890.2342695449315, 4863.0, 5783.831063351243, 5797.753483001175, 5804.593678442638, 5856.3558008618165, 5071.746412679425, 5782.710864456844, 6068.969655151873, 6073.696315184311, 6081.209442772411, 3837.2755343705167, 3928.9607103928593, 3929.54810196831, 3937.625925537184, 3938.7439816411843, 5784.537237021113, 5812.273465816773, 5858.765649373977, 5954.523638109027, 5980.611260268069, 5562.360328562268, 5784.2769653793275, 5820.941790582209, 5821.912671310019, 5828.854278643068, 4841.830535931225, 4993.975030124826, 5643.7742490299925, 5728.598998070095, 5748.54011679073, 4474.0, 4701.412323459567, 4972.483392565302, 5510.862228444321, 5578.442155784389, 4681.57212050328, 4738.962246234152, 5240.2663627093, 5489.890202195854, 5568.888622227614, 5529.751161197836, 5588.441155884379, 5605.467480589501, 5605.635633683797, 5614.29821272341], "value": 4093.6198174953697, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.3285311806904, 751.9135299440566, 759.9354054905331, 770.5646309834939, 780.4302858912994, 13433.328333583331, 15251.389944402225, 15923.442679506219, 16197.352105915748, 16279.59301017475, 14309.284535773222, 14427.350769215383, 14448.5665430037, 14457.132572045684, 14467.78298325526, 677.5968298862169, 700.1388292400351, 700.3066963705945, 821.954792486413, 836.6067948064415, 854.3122786157141, 857.0401150711212, 867.6312567158964, 867.7049803066956, 870.9869351959726, 923.1368670293264, 924.7087167542236, 925.3522534226069, 925.694520808135, 926.7683079230193, 711.3384552366298, 735.577043200162, 919.3977944446399, 921.1985572551889, 922.4972390047441, 535.237286866214, 540.2760301196377, 542.2814770429158, 644.4908522267403, 667.2526770017563, 14720.263986800617, 14764.26178691061, 14778.556643300719, 14810.777838332433, 14824.184669843155, 13492.190468571818, 13783.173009619455, 13793.517226897111, 13801.51694690681, 13878.167309961435, 10669.306495077795, 12027.458764355624, 12384.938075309656, 12456.065795065315, 12475.625731228078, 3932.58707835676, 4433.8448154314765, 4579.244424669925, 4659.324397962277, 4688.859334219979, 112203.0, 114157.0, 120041.0, 120364.39817800942, 120894.39552802268, 10788.892111078945, 10824.837627435594, 10935.316207007938, 10936.45317734126, 10972.890271097187, 21431.142754289966, 21536.246231381825, 21541.56916861654, 21585.920703964737, 21611.567768644538, 7562.395008399315, 7598.772036838904, 7682.577458239851, 8101.878471822927, 8115.3913456491, 4341.066670665822, 4393.934090988638, 4466.397036400044, 4477.462704475483, 4562.247229207143, 3465.9826700866333, 3507.2459421224557, 3537.1864471171775, 3552.6447355264268, 3556.110972256936, 636.3350298937621, 644.674439408096, 660.2736989311719, 663.8937769956784, 672.7847088931495, 510.91569890968316, 607.2864384348374, 612.3978303052476, 635.4013569084993, 648.0959062108333, 8396.832063358699, 8663.48019118855, 8873.378863479624, 8948.776280593038, 9122.31582631292, 611.0, 620.5035971223003, 639.0829160155192, 640.7545780621232, 643.5591619740493, 4246.363045543193, 4328.458942632171, 4342.804573794187, 4395.736255824597, 4437.977810110993, 94677.0, 96891.51554242325, 97223.0, 109036.0, 145522.2723886374, 130118.0, 133557.0, 134146.0, 134499.0, 145095.0, 93547.0, 97301.0, 110784.0, 113193.0, 115584.8441515591, 7362.595057271901, 8275.131111233475, 8407.873881891654, 8409.285210757154, 8473.618687159216, 61670.69164654148, 62661.37338626556, 62837.05744413746, 63932.680336598016, 64111.0, 88519.22961540862, 89475.10524894929, 93907.0, 97471.0, 101834.49082754539, 10974.780504390028, 10997.725056873642, 11125.721856953318, 11739.765204696028, 12102.213356131822, 12472.5010999559, 12616.17994830333, 12772.87227127754, 13085.803712944504, 13449.193048417126, 12087.75824483523, 12515.311657858541, 12534.0, 13979.930100349433, 14216.147031178163, 11441.76885507318, 13391.531296404579, 13629.931850340685, 13658.065447593603, 14548.981571289909, 13352.799708004193, 13828.723425531634, 14081.577552673436, 14557.0, 14570.635734106732, 11211.71970700739, 11570.88429115698, 11920.105992050805, 11993.460294286953, 12114.091443141975, 10113.393196408239, 11259.268147570381, 11593.88406115928, 11743.060555155738, 11920.22518536327], "value": 7646.567748787344, "unit": "score"}], "name": "dromaeo_css", "value": 7192.886758079615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 115.0, 116.0, 116.0, 114.0, 115.0, 117.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 111.0, 111.0, 146.0, 121.0, 110.0, 107.0, 106.0, 141.0, 110.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 182.0, 186.0, 186.0, 182.0, 186.0, 184.0, 184.0, 185.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 90.0, 62.0, 61.0, 58.0, 58.0, 83.0, 58.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 72.0, 67.0, 68.0, 93.0, 68.0, 68.0, 90.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 88.0, 83.0, 88.0, 85.0, 91.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 93.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 87.0, 85.0, 84.0, 83.0, 86.0, 86.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 54.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 70.0, 74.0, 73.0, 70.0, 70.0, 70.0, 71.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 85.0, 80.0, 80.0, 84.0, 85.0, 82.0, 89.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 154.0, 144.0, 139.0, 133.0, 147.0, 156.0, 139.0, 176.0, 152.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 162.0, 163.0, 169.0, 168.0, 164.0, 165.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 66.0, 68.0, 67.0, 66.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1421.5, "alertThreshold": 2.0}]} 16:36:38 INFO - Return code: 0 16:36:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:38 INFO - # TBPL SUCCESS # 16:36:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:38 INFO - 2016-11-05 16:36:38.983 screenresolution[6461:121761] starting screenresolution argv=screenresolution get 16:36:38 INFO - 2016-11-05 16:36:38.985 screenresolution[6461:121761] Display 0: 1600x1200x32@60 16:36:38 INFO - 2016-11-05 16:36:38.991 screenresolution[6462:121764] starting screenresolution argv=screenresolution list 16:36:38 INFO - Available Modes on Display 0 16:36:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:39 INFO - Intel Iris: 16:36:39 INFO - Chipset Model: Intel Iris 16:36:39 INFO - Type: GPU 16:36:39 INFO - Bus: Built-In 16:36:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:39 INFO - Vendor: Intel (0x8086) 16:36:39 INFO - Device ID: 0x0a2e 16:36:39 INFO - Revision ID: 0x0009 16:36:39 INFO - Displays: 16:36:39 INFO - Display: 16:36:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:39 INFO - Display Serial Number: 1600x1200 60 16:36:39 INFO - Main Display: Yes 16:36:39 INFO - Mirror: Off 16:36:39 INFO - Online: Yes 16:36:39 INFO - Rotation: Supported 16:36:39 INFO - Return code: 0 16:36:39 INFO - Running post-action listener: _resource_record_post_action 16:36:39 INFO - [mozharness: 2016-11-05 23:36:39.226805Z] Finished run-tests step (success) 16:36:39 INFO - Running post-run listener: _resource_record_post_run 16:36:39 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 2419712; Write bytes: 664608256; Read time: 25; Write time: 1911 16:36:39 INFO - TinderboxPrint: CPU usage
53.7% 16:36:39 INFO - TinderboxPrint: I/O read bytes / time
2,419,712 / 25 16:36:39 INFO - TinderboxPrint: I/O write bytes / time
664,608,256 / 1,911 16:36:39 INFO - TinderboxPrint: CPU idle
2,243.3 (46.3%) 16:36:39 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 16:36:39 INFO - TinderboxPrint: CPU user
1,622.0 (33.5%) 16:36:39 INFO - TinderboxPrint: Swap in / out
366,514,176 / 0 16:36:39 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 358478336; Write bytes: 356022272; Read time: 27331; Write time: 715 16:36:39 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1551360; Write bytes: 297526784; Read time: 20; Write time: 1159 16:36:39 INFO - Running post-run listener: _upload_blobber_files 16:36:39 INFO - Blob upload gear active. 16:36:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:39 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 16:36:39 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'] 16:36:39 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 16:36:40 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:40 INFO - (blobuploader) - INFO - Done attempting. 16:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:41 INFO - (blobuploader) - INFO - Done attempting. 16:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:36:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:44 INFO - (blobuploader) - INFO - Done attempting. 16:36:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:44 INFO - Return code: 0 16:36:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a93b4ad8e88a5c66e3afae2199e0bcbbcd390b9c7759b5dfb3f1356fad636e987f7169b4ccc048033cca0842d9a51084ee286c1ab4b7f47d9041a223e9fd6cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fcc5010854e7b9653b8fa6b62829d3579ee5b033fd6870b8566d9843e72bbaa15037b34300e7e301665a8cc185b9ea45ac20aacfa8379c75a230c916184be3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b509ba9050ed304b2a8416320b52b410c8acee44287b08c8abfd3b29c2a525864bdd2c8013a7ba10636b05e1dbcf9eb0665a1dd732ff91e414323019a130c6d1"} 16:36:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:44 INFO - Contents: 16:36:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a93b4ad8e88a5c66e3afae2199e0bcbbcd390b9c7759b5dfb3f1356fad636e987f7169b4ccc048033cca0842d9a51084ee286c1ab4b7f47d9041a223e9fd6cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fcc5010854e7b9653b8fa6b62829d3579ee5b033fd6870b8566d9843e72bbaa15037b34300e7e301665a8cc185b9ea45ac20aacfa8379c75a230c916184be3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b509ba9050ed304b2a8416320b52b410c8acee44287b08c8abfd3b29c2a525864bdd2c8013a7ba10636b05e1dbcf9eb0665a1dd732ff91e414323019a130c6d1"} 16:36:44 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:44 INFO - Copying logs to upload dir... 16:36:44 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.145760 ========= master_lag: 3.48 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-05 16:36:48.042518) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.046054) ========= 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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a93b4ad8e88a5c66e3afae2199e0bcbbcd390b9c7759b5dfb3f1356fad636e987f7169b4ccc048033cca0842d9a51084ee286c1ab4b7f47d9041a223e9fd6cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fcc5010854e7b9653b8fa6b62829d3579ee5b033fd6870b8566d9843e72bbaa15037b34300e7e301665a8cc185b9ea45ac20aacfa8379c75a230c916184be3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b509ba9050ed304b2a8416320b52b410c8acee44287b08c8abfd3b29c2a525864bdd2c8013a7ba10636b05e1dbcf9eb0665a1dd732ff91e414323019a130c6d1"} build_url:https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a93b4ad8e88a5c66e3afae2199e0bcbbcd390b9c7759b5dfb3f1356fad636e987f7169b4ccc048033cca0842d9a51084ee286c1ab4b7f47d9041a223e9fd6cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fcc5010854e7b9653b8fa6b62829d3579ee5b033fd6870b8566d9843e72bbaa15037b34300e7e301665a8cc185b9ea45ac20aacfa8379c75a230c916184be3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b509ba9050ed304b2a8416320b52b410c8acee44287b08c8abfd3b29c2a525864bdd2c8013a7ba10636b05e1dbcf9eb0665a1dd732ff91e414323019a130c6d1"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.436086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.436384) ========= 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.aQ58rKYrUX/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.iHCwuzFAUB/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005371 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.493047) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-11-05 16:36:48.493341) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-11-05 16:36:52.222751) ========= ========= Total master_lag: 4.06 =========