builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0371 starttime: 1477012267.69 results: success (0) buildid: 20161020165949 builduid: df213a843fca46d2829e25f439558eba revision: d61548e284cacc0dea96ae32f15a50dff7c4eb24 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.694626) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.695075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.695365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.719594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.719932) ========= 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.q1CXifHa7X/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.ujBvoCfpvm/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-20 18:11:07-- 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% 18.5M=0.001s 2016-10-20 18:11:07 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.865019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.865345) ========= 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.q1CXifHa7X/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.ujBvoCfpvm/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.025115 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:07.914238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 18:11:07.914641) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d61548e284cacc0dea96ae32f15a50dff7c4eb24 --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 d61548e284cacc0dea96ae32f15a50dff7c4eb24 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q1CXifHa7X/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.ujBvoCfpvm/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-20 18:11:07,998 truncating revision to first 12 chars 2016-10-20 18:11:07,998 Setting DEBUG logging. 2016-10-20 18:11:07,998 attempt 1/10 2016-10-20 18:11:07,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d61548e284ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 18:11:09,211 unpacking tar archive at: mozilla-aurora-d61548e284ca/testing/mozharness/ program finished with exit code 0 elapsedTime=1.503464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 18:11:09.440002) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:09.440344) ========= script_repo_revision: d61548e284cacc0dea96ae32f15a50dff7c4eb24 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:09.440729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:09.440994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 18:11:09.459186) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-20 18:11:09.459622) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q1CXifHa7X/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.ujBvoCfpvm/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:09 INFO - MultiFileLogger online at 20161020 18:11:09 in /builds/slave/test 18:11:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:11:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:09 INFO - {'append_to_log': False, 18:11:09 INFO - 'base_work_dir': '/builds/slave/test', 18:11:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:11:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:09 INFO - 'branch': 'Mozilla-Aurora', 18:11:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:09 INFO - 'config_files': ('talos/mac_config.py',), 18:11:09 INFO - 'default_actions': ('clobber', 18:11:09 INFO - 'read-buildbot-config', 18:11:09 INFO - 'download-and-extract', 18:11:09 INFO - 'populate-webroot', 18:11:09 INFO - 'create-virtualenv', 18:11:09 INFO - 'install', 18:11:09 INFO - 'run-tests'), 18:11:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:09 INFO - 'download_minidump_stackwalk': True, 18:11:09 INFO - 'download_symbols': 'ondemand', 18:11:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:09 INFO - 'installer_path': 'installer.exe', 18:11:09 INFO - 'log_level': 'info', 18:11:09 INFO - 'log_name': 'talos', 18:11:09 INFO - 'log_to_console': True, 18:11:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:11:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:11:09 INFO - 'opt_config_files': (), 18:11:09 INFO - 'pip_index': False, 18:11:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:09 INFO - 'cmd': ('bash', 18:11:09 INFO - '-c', 18:11:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:09 INFO - 'enabled': True, 18:11:09 INFO - 'halt_on_failure': False, 18:11:09 INFO - 'name': 'check_screen_resolution'},), 18:11:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:09 INFO - 'cmd': ('bash', 18:11:09 INFO - '-c', 18:11:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:09 INFO - 'enabled': True, 18:11:09 INFO - 'halt_on_failure': False, 18:11:09 INFO - 'name': 'check_screen_resolution'},), 18:11:09 INFO - 'run_cmd_checks_enabled': True, 18:11:09 INFO - 'sps_profile': False, 18:11:09 INFO - 'sps_profile_interval': 0, 18:11:09 INFO - 'suite': 'dromaeojs-e10s', 18:11:09 INFO - 'system_bits': '32', 18:11:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:09 INFO - 'title': 't-yosemite-r7-0371', 18:11:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:09 INFO - 'use_talos_json': True, 18:11:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:09 INFO - 'work_dir': 'build'} 18:11:09 INFO - [mozharness: 2016-10-21 01:11:09.658485Z] Running clobber step. 18:11:09 INFO - Running pre-action listener: _resource_record_pre_action 18:11:09 INFO - Running main action method: clobber 18:11:09 INFO - rmtree: /builds/slave/test/build 18:11:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:11 INFO - Running post-action listener: _resource_record_post_action 18:11:11 INFO - [mozharness: 2016-10-21 01:11:11.866325Z] Finished clobber step (success) 18:11:11 INFO - [mozharness: 2016-10-21 01:11:11.866451Z] Running read-buildbot-config step. 18:11:11 INFO - Running pre-action listener: _resource_record_pre_action 18:11:11 INFO - Running main action method: read_buildbot_config 18:11:11 INFO - Using buildbot properties: 18:11:11 INFO - { 18:11:11 INFO - "project": "", 18:11:11 INFO - "product": "firefox", 18:11:11 INFO - "script_repo_revision": "production", 18:11:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:11:11 INFO - "repository": "", 18:11:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:11:11 INFO - "buildid": "20161020165949", 18:11:11 INFO - "pgo_build": "False", 18:11:11 INFO - "basedir": "/builds/slave/test", 18:11:11 INFO - "buildnumber": 9, 18:11:11 INFO - "slavename": "t-yosemite-r7-0371", 18:11:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:11:11 INFO - "platform": "yosemite_r7", 18:11:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:11:11 INFO - "branch": "mozilla-aurora", 18:11:11 INFO - "repo_path": "releases/mozilla-aurora", 18:11:11 INFO - "revision": "d61548e284cacc0dea96ae32f15a50dff7c4eb24", 18:11:11 INFO - "stage_platform": "macosx64", 18:11:11 INFO - "builduid": "df213a843fca46d2829e25f439558eba", 18:11:11 INFO - "slavebuilddir": "test" 18:11:11 INFO - } 18:11:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 18:11:11 INFO - Running post-action listener: _resource_record_post_action 18:11:11 INFO - [mozharness: 2016-10-21 01:11:11.869896Z] Finished read-buildbot-config step (success) 18:11:11 INFO - [mozharness: 2016-10-21 01:11:11.869996Z] Running download-and-extract step. 18:11:11 INFO - Running pre-action listener: _resource_record_pre_action 18:11:11 INFO - Running main action method: download_and_extract 18:11:11 INFO - mkdir: /builds/slave/test/build/tests 18:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:11 INFO - trying https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 18:11:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/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 18:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/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 18:11:12 INFO - Downloaded 1199 bytes. 18:11:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:11:12 INFO - Using the following test package requirements: 18:11:12 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:11:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 18:11:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 18:11:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'jsshell-mac.zip'], 18:11:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 18:11:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:11:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 18:11:12 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 18:11:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 18:11:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:11:12 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 18:11:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:11:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:11:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:11:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:11:13 INFO - Expected file size: 16436367 18:11:20 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 18:11:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:11:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:11:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:11:20 INFO - Expected file size: 16436367 18:11:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 18:11:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 18:11:28 INFO - Expected file size: 14414081 18:11: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')]} 18:11:28 INFO - trying https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:11:28 INFO - Downloading https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 18:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/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 18:11:31 INFO - Downloaded 115425695 bytes. 18:11:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:11:31 INFO - mkdir: /builds/slave/test/properties 18:11:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:11:31 INFO - Writing to file /builds/slave/test/properties/build_url 18:11:31 INFO - Contents: 18:11:31 INFO - build_url:https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:11:32 INFO - Running post-action listener: _resource_record_post_action 18:11:32 INFO - Running post-action listener: set_extra_try_arguments 18:11:32 INFO - [mozharness: 2016-10-21 01:11:32.554838Z] Finished download-and-extract step (success) 18:11:32 INFO - [mozharness: 2016-10-21 01:11:32.554962Z] Running populate-webroot step. 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: populate_webroot 18:11:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:11:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:11:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:11:32 INFO - '--tppagecycles', 18:11:32 INFO - '7'], 18:11:32 INFO - 'tests': ['tsvgm']}}, 18:11:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:11:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:11:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:11:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:11:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['damp', 'tps']}, 18:11:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'tests': ['damp', 'tps']}, 18:11:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['dromaeo_dom']}, 18:11:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:11:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['basic_compositor_video']}, 18:11:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:11:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['a11yr', 18:11:32 INFO - 'ts_paint', 18:11:32 INFO - 'tpaint', 18:11:32 INFO - 'sessionrestore', 18:11:32 INFO - 'sessionrestore_no_auto_restore', 18:11:32 INFO - 'tabpaint']}, 18:11:32 INFO - 'other-e10s': {'tests': ['a11yr', 18:11:32 INFO - 'ts_paint', 18:11:32 INFO - 'tpaint', 18:11:32 INFO - 'sessionrestore', 18:11:32 INFO - 'sessionrestore_no_auto_restore', 18:11:32 INFO - 'tabpaint']}, 18:11:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:11:32 INFO - 'ts_paint', 18:11:32 INFO - 'tpaint', 18:11:32 INFO - 'sessionrestore', 18:11:32 INFO - 'sessionrestore_no_auto_restore', 18:11:32 INFO - 'tabpaint']}, 18:11:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:11:32 INFO - 'ts_paint', 18:11:32 INFO - 'tpaint', 18:11:32 INFO - 'sessionrestore', 18:11:32 INFO - 'sessionrestore_no_auto_restore', 18:11:32 INFO - 'tabpaint']}, 18:11:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['a11yr', 18:11:32 INFO - 'ts_paint', 18:11:32 INFO - 'tpaint', 18:11:32 INFO - 'sessionrestore', 18:11:32 INFO - 'sessionrestore_no_auto_restore', 18:11:32 INFO - 'tabpaint']}, 18:11:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['a11yr', 18:11:32 INFO - 'ts_paint', 18:11:32 INFO - 'tpaint', 18:11:32 INFO - 'sessionrestore', 18:11:32 INFO - 'sessionrestore_no_auto_restore', 18:11:32 INFO - 'tabpaint']}, 18:11:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['tsvgx', 18:11:32 INFO - 'tsvgr_opacity', 18:11:32 INFO - 'tart', 18:11:32 INFO - 'tscrollx', 18:11:32 INFO - 'cart']}, 18:11:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:11:32 INFO - 'tsvgr_opacity', 18:11:32 INFO - 'tart', 18:11:32 INFO - 'tscrollx', 18:11:32 INFO - 'cart']}, 18:11:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'talos_options': ['--disable-e10s'], 18:11:32 INFO - 'tests': ['tp5o']}, 18:11:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'tests': ['tp5o']}, 18:11:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'talos_options': ['--disable-e10s', 18:11:32 INFO - '--xperf_path', 18:11:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:32 INFO - 'tests': ['tp5n']}, 18:11:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:32 INFO - 'talos_options': ['--xperf_path', 18:11:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:32 INFO - 'tests': ['tp5n']}}, 18:11:32 INFO - 'talos.zip': {'path': '', 18:11:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:11:32 INFO - Running post-action listener: _resource_record_post_action 18:11:32 INFO - [mozharness: 2016-10-21 01:11:32.573889Z] Finished populate-webroot step (success) 18:11:32 INFO - [mozharness: 2016-10-21 01:11:32.573983Z] Running create-virtualenv step. 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: create_virtualenv 18:11:32 INFO - Creating virtualenv /builds/slave/test/build/venv 18:11:32 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 18:11:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:11:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:11:32 INFO - Using real prefix '/tools/python27' 18:11:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:36 INFO - Installing pip.................done. 18:11:36 INFO - Return code: 0 18:11:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:36 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:36 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 18:11:36 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 18:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:36 INFO - 'HOME': '/Users/cltbld', 18:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:36 INFO - 'LOGNAME': 'cltbld', 18:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:36 INFO - 'MOZ_NO_REMOTE': '1', 18:11:36 INFO - 'NO_EM_RESTART': '1', 18:11:36 INFO - 'PAGER': '/bin/cat', 18:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:36 INFO - 'PWD': '/builds/slave/test', 18:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:36 INFO - 'SHELL': '/bin/bash', 18:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:36 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:36 INFO - 'USER': 'cltbld', 18:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:36 INFO - 'XPC_FLAGS': '0x0', 18:11:36 INFO - 'XPC_SERVICE_NAME': '0', 18:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:36 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 18:11:36 INFO - Cleaning up... 18:11:36 INFO - Return code: 0 18:11:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:36 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:36 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 18:11:36 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 18:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:36 INFO - 'HOME': '/Users/cltbld', 18:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:36 INFO - 'LOGNAME': 'cltbld', 18:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:36 INFO - 'MOZ_NO_REMOTE': '1', 18:11:36 INFO - 'NO_EM_RESTART': '1', 18:11:36 INFO - 'PAGER': '/bin/cat', 18:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:36 INFO - 'PWD': '/builds/slave/test', 18:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:36 INFO - 'SHELL': '/bin/bash', 18:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:36 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:36 INFO - 'USER': 'cltbld', 18:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:36 INFO - 'XPC_FLAGS': '0x0', 18:11:36 INFO - 'XPC_SERVICE_NAME': '0', 18:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:36 INFO - Downloading/unpacking psutil>=3.1.1 18:11:36 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 18:11:36 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 18:11:36 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 18:11:36 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 18:11:36 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 18:11:36 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 18:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:39 INFO - Installing collected packages: psutil 18:11:39 INFO - Running setup.py install for psutil 18:11:39 INFO - building 'psutil._psutil_osx' extension 18:11:39 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 18:11:40 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 18:11:40 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 18:11:40 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 18:11:40 INFO - building 'psutil._psutil_posix' extension 18:11:40 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 18:11:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:11:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:11:40 INFO - ^ 18:11:40 INFO - 1 warning generated. 18:11:40 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 18:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:40 INFO - Successfully installed psutil 18:11:40 INFO - Cleaning up... 18:11:41 INFO - Return code: 0 18:11:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:11:41 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')]} 18:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:41 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')]} 18:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:41 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:41 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 18:11:41 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 18:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:41 INFO - 'HOME': '/Users/cltbld', 18:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:41 INFO - 'LOGNAME': 'cltbld', 18:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:41 INFO - 'MOZ_NO_REMOTE': '1', 18:11:41 INFO - 'NO_EM_RESTART': '1', 18:11:41 INFO - 'PAGER': '/bin/cat', 18:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:41 INFO - 'PWD': '/builds/slave/test', 18:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:41 INFO - 'SHELL': '/bin/bash', 18:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:41 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:41 INFO - 'USER': 'cltbld', 18:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:41 INFO - 'XPC_FLAGS': '0x0', 18:11:41 INFO - 'XPC_SERVICE_NAME': '0', 18:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:11:43 INFO - Installing collected packages: mozsystemmonitor 18:11:43 INFO - Running setup.py install for mozsystemmonitor 18:11:44 INFO - Successfully installed mozsystemmonitor 18:11:44 INFO - Cleaning up... 18:11:44 INFO - Return code: 0 18:11:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:44 INFO - 'HOME': '/Users/cltbld', 18:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:44 INFO - 'LOGNAME': 'cltbld', 18:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:44 INFO - 'MOZ_NO_REMOTE': '1', 18:11:44 INFO - 'NO_EM_RESTART': '1', 18:11:44 INFO - 'PAGER': '/bin/cat', 18:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:44 INFO - 'PWD': '/builds/slave/test', 18:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:44 INFO - 'SHELL': '/bin/bash', 18:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:44 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:44 INFO - 'USER': 'cltbld', 18:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:44 INFO - 'XPC_FLAGS': '0x0', 18:11:44 INFO - 'XPC_SERVICE_NAME': '0', 18:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:11:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:47 INFO - Downloading functools32-3.2.3-2.tar.gz 18:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:11:47 INFO - warning: no files found matching '*.txt' 18:11:47 INFO - no previously-included directories found matching 'build' 18:11:47 INFO - no previously-included directories found matching 'dist' 18:11:47 INFO - no previously-included directories found matching '.git*' 18:11:47 INFO - Installing collected packages: jsonschema, functools32 18:11:47 INFO - Running setup.py install for functools32 18:11:47 INFO - warning: no files found matching '*.txt' 18:11:47 INFO - no previously-included directories found matching 'build' 18:11:47 INFO - no previously-included directories found matching 'dist' 18:11:47 INFO - no previously-included directories found matching '.git*' 18:11:47 INFO - Successfully installed jsonschema functools32 18:11:47 INFO - Cleaning up... 18:11:47 INFO - Return code: 0 18:11:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:47 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:47 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 18:11:47 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 18:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:47 INFO - 'HOME': '/Users/cltbld', 18:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:47 INFO - 'LOGNAME': 'cltbld', 18:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:47 INFO - 'MOZ_NO_REMOTE': '1', 18:11:47 INFO - 'NO_EM_RESTART': '1', 18:11:47 INFO - 'PAGER': '/bin/cat', 18:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:47 INFO - 'PWD': '/builds/slave/test', 18:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:47 INFO - 'SHELL': '/bin/bash', 18:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:47 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:47 INFO - 'USER': 'cltbld', 18:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:47 INFO - 'XPC_FLAGS': '0x0', 18:11:47 INFO - 'XPC_SERVICE_NAME': '0', 18:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:11:48 INFO - Cleaning up... 18:11:48 INFO - Return code: 0 18:11:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:11:48 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')]} 18:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:48 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')]} 18:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:48 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:48 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 18:11:48 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 18:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:48 INFO - 'HOME': '/Users/cltbld', 18:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:48 INFO - 'LOGNAME': 'cltbld', 18:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:48 INFO - 'MOZ_NO_REMOTE': '1', 18:11:48 INFO - 'NO_EM_RESTART': '1', 18:11:48 INFO - 'PAGER': '/bin/cat', 18:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:48 INFO - 'PWD': '/builds/slave/test', 18:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:48 INFO - 'SHELL': '/bin/bash', 18:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:48 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:48 INFO - 'USER': 'cltbld', 18:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:48 INFO - 'XPC_FLAGS': '0x0', 18:11:48 INFO - 'XPC_SERVICE_NAME': '0', 18:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:48 INFO - Downloading/unpacking blobuploader==1.2.4 18:11:48 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 18:11:48 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 18:11:48 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 18:11:48 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 18:11:48 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 18:11:48 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 18:11:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:11:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:11:50 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 18:11:50 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 18:11:50 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 18:11:50 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 18:11:50 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 18:11:50 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 18:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:11:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:11:51 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 18:11:51 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 18:11:51 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 18:11:51 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 18:11:51 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 18:11:51 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 18:11:52 INFO - Downloading docopt-0.6.1.tar.gz 18:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:11:52 INFO - Running setup.py install for blobuploader 18:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:11:52 INFO - Running setup.py install for requests 18:11:52 INFO - Running setup.py install for docopt 18:11:52 INFO - Successfully installed blobuploader requests docopt 18:11:52 INFO - Cleaning up... 18:11:52 INFO - Return code: 0 18:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:52 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:52 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 18:11:52 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 18:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:52 INFO - 'HOME': '/Users/cltbld', 18:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:52 INFO - 'LOGNAME': 'cltbld', 18:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:52 INFO - 'MOZ_NO_REMOTE': '1', 18:11:52 INFO - 'NO_EM_RESTART': '1', 18:11:52 INFO - 'PAGER': '/bin/cat', 18:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:52 INFO - 'PWD': '/builds/slave/test', 18:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:52 INFO - 'SHELL': '/bin/bash', 18:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:52 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:52 INFO - 'USER': 'cltbld', 18:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:53 INFO - 'XPC_FLAGS': '0x0', 18:11:53 INFO - 'XPC_SERVICE_NAME': '0', 18:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-hAIrN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-izkBqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-g471GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-5F0odv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-xaA6FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ZkHGSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-45YewL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:53 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-XXUhmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-0upiCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-sneo2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-pAXnZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-mjDkDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-zOZt0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-k9ThNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-dSZP5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-KNZDq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:54 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-wVGyb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:11:55 INFO - Running setup.py install for manifestparser 18:11:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:11:55 INFO - Running setup.py install for mozcrash 18:11:55 INFO - Running setup.py install for mozdebug 18:11:55 INFO - Running setup.py install for mozdevice 18:11:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:11:55 INFO - Running setup.py install for mozfile 18:11:55 INFO - Running setup.py install for mozhttpd 18:11:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:11:55 INFO - Running setup.py install for mozinfo 18:11:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Running setup.py install for mozInstall 18:11:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Running setup.py install for mozleak 18:11:56 INFO - Running setup.py install for mozlog 18:11:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Running setup.py install for moznetwork 18:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Running setup.py install for mozprocess 18:11:56 INFO - Running setup.py install for mozprofile 18:11:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:11:56 INFO - Running setup.py install for mozrunner 18:11:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:11:57 INFO - Running setup.py install for mozscreenshot 18:11:57 INFO - Running setup.py install for moztest 18:11:57 INFO - Running setup.py install for mozversion 18:11:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:11:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:11:57 INFO - Cleaning up... 18:11:57 INFO - Return code: 0 18:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:11:57 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 18:11:57 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 18:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:57 INFO - 'HOME': '/Users/cltbld', 18:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:57 INFO - 'LOGNAME': 'cltbld', 18:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:57 INFO - 'MOZ_NO_REMOTE': '1', 18:11:57 INFO - 'NO_EM_RESTART': '1', 18:11:57 INFO - 'PAGER': '/bin/cat', 18:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:57 INFO - 'PWD': '/builds/slave/test', 18:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:57 INFO - 'SHELL': '/bin/bash', 18:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:11:57 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:57 INFO - 'USER': 'cltbld', 18:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:57 INFO - 'XPC_FLAGS': '0x0', 18:11:57 INFO - 'XPC_SERVICE_NAME': '0', 18:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Qe5UJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:58 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)) 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-C6k7lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:58 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)) 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-qw1VVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:58 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)) 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-e9ibMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:58 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)) 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-qlMUsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:58 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)) 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-7FFcgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:58 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)) 18:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:58 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-ood4wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-zibnXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-Jn9mHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-OtqbOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-pi983j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-6kmuq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-VJnv7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-K5Z_yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-WCOToJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-eMQ6DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:59 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)) 18:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:59 INFO - Running setup.py (path:/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/pip-I2DaPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:00 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)) 18:12:00 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)) 18:12:00 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)) 18:12:00 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)) 18:12:00 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)) 18:12:00 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)) 18:12:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:02 INFO - Downloading blessings-1.6.tar.gz 18:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:03 INFO - Installing collected packages: blessings 18:12:03 INFO - Running setup.py install for blessings 18:12:03 INFO - Successfully installed blessings 18:12:03 INFO - Cleaning up... 18:12:03 INFO - Return code: 0 18:12:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:03 INFO - Reading from file tmpfile_stdout 18:12:03 INFO - Current package versions: 18:12:03 INFO - blessings == 1.6 18:12:03 INFO - blobuploader == 1.2.4 18:12:03 INFO - docopt == 0.6.1 18:12:03 INFO - functools32 == 3.2.3-2 18:12:03 INFO - jsonschema == 2.5.1 18:12:03 INFO - manifestparser == 1.1 18:12:03 INFO - mozInstall == 1.12 18:12:03 INFO - mozcrash == 0.17 18:12:03 INFO - mozdebug == 0.1 18:12:03 INFO - mozdevice == 0.48 18:12:03 INFO - mozfile == 1.2 18:12:03 INFO - mozhttpd == 0.7 18:12:03 INFO - mozinfo == 0.9 18:12:03 INFO - mozleak == 0.1 18:12:03 INFO - mozlog == 3.4 18:12:03 INFO - moznetwork == 0.27 18:12:03 INFO - mozprocess == 0.23 18:12:03 INFO - mozprofile == 0.28 18:12:03 INFO - mozrunner == 6.12 18:12:03 INFO - mozscreenshot == 0.1 18:12:03 INFO - mozsystemmonitor == 0.3 18:12:03 INFO - moztest == 0.7 18:12:03 INFO - mozversion == 1.4 18:12:03 INFO - psutil == 3.1.1 18:12:03 INFO - requests == 1.2.3 18:12:03 INFO - wsgiref == 0.1.2 18:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:03 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')]} 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:03 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')]} 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:03 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:12:03 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 18:12:03 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 18:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:03 INFO - 'HOME': '/Users/cltbld', 18:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:03 INFO - 'LOGNAME': 'cltbld', 18:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:03 INFO - 'MOZ_NO_REMOTE': '1', 18:12:03 INFO - 'NO_EM_RESTART': '1', 18:12:03 INFO - 'PAGER': '/bin/cat', 18:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:03 INFO - 'PWD': '/builds/slave/test', 18:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:03 INFO - 'SHELL': '/bin/bash', 18:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:12:03 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:03 INFO - 'USER': 'cltbld', 18:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:03 INFO - 'XPC_FLAGS': '0x0', 18:12:03 INFO - 'XPC_SERVICE_NAME': '0', 18:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 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)) 18:12:03 INFO - Cleaning up... 18:12:03 INFO - Return code: 0 18:12:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:03 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')]} 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:03 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')]} 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:03 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 0x10ac71490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10abe7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2b95c8c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, '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.q1CXifHa7X/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.ujBvoCfpvm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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 18:12:03 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 18:12:03 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 18:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:03 INFO - 'HOME': '/Users/cltbld', 18:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:03 INFO - 'LOGNAME': 'cltbld', 18:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:03 INFO - 'MOZ_NO_REMOTE': '1', 18:12:03 INFO - 'NO_EM_RESTART': '1', 18:12:03 INFO - 'PAGER': '/bin/cat', 18:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:03 INFO - 'PWD': '/builds/slave/test', 18:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:03 INFO - 'SHELL': '/bin/bash', 18:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:12:03 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:03 INFO - 'USER': 'cltbld', 18:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:03 INFO - 'XPC_FLAGS': '0x0', 18:12:03 INFO - 'XPC_SERVICE_NAME': '0', 18:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:04 INFO - Cleaning up... 18:12:04 INFO - Return code: 0 18:12:04 INFO - Running post-action listener: _resource_record_post_action 18:12:04 INFO - Running post-action listener: _start_resource_monitoring 18:12:04 INFO - Starting resource monitoring. 18:12:04 INFO - [mozharness: 2016-10-21 01:12:04.175383Z] Finished create-virtualenv step (success) 18:12:04 INFO - [mozharness: 2016-10-21 01:12:04.176358Z] Running install step. 18:12:04 INFO - Running pre-action listener: _resource_record_pre_action 18:12:04 INFO - Running main action method: install 18:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:04 INFO - Reading from file tmpfile_stdout 18:12:04 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:04 INFO - Reading from file tmpfile_stdout 18:12:04 INFO - Output received: 18:12:04 INFO - Usage: mozinstall [options] installer 18:12:04 INFO - Options: 18:12:04 INFO - -h, --help show this help message and exit 18:12:04 INFO - -d DEST, --destination=DEST 18:12:04 INFO - Directory to install application into. [default: 18:12:04 INFO - "/builds/slave/test"] 18:12:04 INFO - --app=APP Application being installed. [default: firefox] 18:12:04 INFO - mkdir: /builds/slave/test/build/application 18:12:04 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'] 18:12:04 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 18:12:36 INFO - Reading from file tmpfile_stdout 18:12:36 INFO - Output received: 18:12:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:12:36 INFO - Running post-action listener: _resource_record_post_action 18:12:36 INFO - [mozharness: 2016-10-21 01:12:36.760991Z] Finished install step (success) 18:12:36 INFO - [mozharness: 2016-10-21 01:12:36.761108Z] Running run-tests step. 18:12:36 INFO - Running pre-action listener: _resource_record_pre_action 18:12:36 INFO - Running main action method: run_tests 18:12:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:12:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:12:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:12:36 INFO - 2016-10-20 18:12:36.775 screenresolution[1636:7554] starting screenresolution argv=screenresolution get 18:12:36 INFO - 2016-10-20 18:12:36.777 screenresolution[1636:7554] Display 0: 1600x1200x32@60 18:12:36 INFO - 2016-10-20 18:12:36.783 screenresolution[1637:7557] starting screenresolution argv=screenresolution list 18:12:36 INFO - Available Modes on Display 0 18:12:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:12:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:12:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:12:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:12:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:12:37 INFO - Intel Iris: 18:12:37 INFO - Chipset Model: Intel Iris 18:12:37 INFO - Type: GPU 18:12:37 INFO - Bus: Built-In 18:12:37 INFO - VRAM (Dynamic, Max): 1536 MB 18:12:37 INFO - Vendor: Intel (0x8086) 18:12:37 INFO - Device ID: 0x0a2e 18:12:37 INFO - Revision ID: 0x0009 18:12:37 INFO - Displays: 18:12:37 INFO - Display: 18:12:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:12:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:12:37 INFO - Display Serial Number: 1600x1200 60 18:12:37 INFO - Main Display: Yes 18:12:37 INFO - Mirror: Off 18:12:37 INFO - Online: Yes 18:12:37 INFO - Rotation: Supported 18:12:37 INFO - Return code: 0 18:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:37 INFO - Python 2.7.3 18:12:37 INFO - Return code: 0 18:12:37 INFO - grabbing minidump binary from tooltool 18:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:37 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 0x10aa85d30>, '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 0x10a8ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aa7db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:37 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 18:12:37 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 18:12:37 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 18:12:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:37 INFO - Return code: 0 18:12:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:12:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:12:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0371 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:12:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q1CXifHa7X/Render', 18:12:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:37 INFO - 'HOME': '/Users/cltbld', 18:12:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:37 INFO - 'LOGNAME': 'cltbld', 18:12:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:37 INFO - 'MOZ_NO_REMOTE': '1', 18:12:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:37 INFO - 'NO_EM_RESTART': '1', 18:12:37 INFO - 'PAGER': '/bin/cat', 18:12:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:37 INFO - 'PWD': '/builds/slave/test', 18:12:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:37 INFO - 'SHELL': '/bin/bash', 18:12:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ujBvoCfpvm/Listeners', 18:12:37 INFO - 'TMPDIR': '/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/', 18:12:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:37 INFO - 'USER': 'cltbld', 18:12:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:37 INFO - 'XPC_FLAGS': '0x0', 18:12:37 INFO - 'XPC_SERVICE_NAME': '0', 18:12:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0371', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:12:37 INFO - mozversion application_buildid: 20161020165949 18:12:37 INFO - mozversion application_changeset: d61548e284cacc0dea96ae32f15a50dff7c4eb24 18:12:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:12:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:37 INFO - mozversion application_name: Firefox 18:12:37 INFO - mozversion application_remotingname: firefox-dev 18:12:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:12:37 INFO - mozversion application_vendor: Mozilla 18:12:37 INFO - mozversion application_version: 51.0a2 18:12:37 INFO - mozversion platform_buildid: 20161020165949 18:12:37 INFO - mozversion platform_changeset: d61548e284cacc0dea96ae32f15a50dff7c4eb24 18:12:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:12:37 INFO - mozversion platform_version: 51.0a2 18:12:37 INFO - using testdate: 1477012357 18:12:37 INFO - actual date: 1477012357 18:12:37 INFO - starting webserver on 'localhost:49273' 18:12:37 INFO - SUITE-START | Running 2 tests 18:12:37 INFO - TEST-START | dromaeo_css 18:12:37 INFO - operating with platform_type : mac_ 18:12:37 INFO - Initialising browser for dromaeo_css test... 18:12:37 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpGrbvyU/profile http://localhost:49273/getInfo.html) 18:12:40 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 18:12:40 INFO - PROCESS | 1647 | colorDepth:24 18:12:40 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 18:12:40 INFO - PROCESS | 1647 | __metrics 18:12:40 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:12:41 INFO - TEST-INFO | 1647: exit 0 18:12:41 INFO - Browser initialized. 18:12:41 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:41 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpGrbvyU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:12:53 INFO - PROCESS | 1650 | RSS: Main: 225587200 18:12:53 INFO - PROCESS | 1650 | 18:13:42 INFO - PROCESS | 1650 | 1477012422792 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] 18:15:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 18:15:56 INFO - PROCESS | 1650 | RSS: Main: 237191168 18:15:56 INFO - PROCESS | 1650 | 18:18:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 18:18:59 INFO - PROCESS | 1650 | RSS: Main: 248995840 18:18:59 INFO - PROCESS | 1650 | 18:22:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 18:22:02 INFO - PROCESS | 1650 | RSS: Main: 251371520 18:22:02 INFO - PROCESS | 1650 | 18:25:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 18:25:04 INFO - PROCESS | 1650 | RSS: Main: 251654144 18:25:04 INFO - PROCESS | 1650 | 18:28:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 18:28:07 INFO - PROCESS | 1650 | RSS: Main: 256233472 18:28:07 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 18:31:10 INFO - PROCESS | 1650 | RSS: Main: 259072000 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | __start_tp_report 18:31:10 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 18:31:10 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 18:31:10 INFO - PROCESS | 1650 | |i|pagename|runs| 18:31:10 INFO - PROCESS | 1650 | |0;dojo.html;3363.663633636635;3397.2865698203377;3410.249745056088;3413.163774875155;3441.27733176033;5795.5073818725405;5811.941880581193;5826.417358264182;5899.085641725539;5930.288365396148;5874.9412505874925;5934.940650593493;5941.197938278331;5961.046232602785;5973.133895585149;5270.077736396134;5304.310439642841;5339.5728341732565;5371.489708477708;5414.1608050752;5347.358317001946;5378.46215378463;5384.6769193848295;5388.299521062257;5392.514673679368;5239.345081864767;5259.211118332242;5369.9463005370035;5394.649347792381;5422.186671999192;4780.757003179181;4813.302071199656;4982.651214414992;5136.5890728741615;5291.973540132294;4258.765767882765;5274.182501712203;5290.1800220965815;5303.337082864642;5359.115745901921;5687.544996400278;5904.350521442638;5905.704714764244;6001.879962400728;6049.637021778663;6145.047517634774;6206.472449841769;6214.161088253073;6220.533459990474;6230.501559875199;6279.591826531307;6280.937190628127;6303.3066362700065;6311.558190926637;6334;5862.12068189775;6044.395560444008;6048.395160483917;6055.333913269536;6064.332923378469;6262;6312.084747711648;6340.365963403623;6372;6376.234851817811;6249.937500624936;6265.4361107499635;6282.748690052346;6286.05709143623;6307.400796924285;6155.292141403706;6180.289266734293;6240.4071613196675;6310.810675679737;6324.525660575383;6239.469645080128;6283.622982621057;6288.654124023223;6294.937050629526;6318.494520438354;6242.563020588606;6253.812385628438;6280.9685951569945;6290.748370065237;6296.716647750771;4898.559129678275;4956.8351437412175;4984.576311013532;5011.997600479918;5028.296038554606;3798.9430158547643;4425.181341451842;4433.046894917608;4452.287633978548;4486.64106871456;5764.221830052889;5857.47282744555;5881.441263080001;5884.382139875337;5906.202662640574;6106.73370229429;6244.250689917239;6252.843678908063;6277.403646653652;6285.43431091204;5806.622569532967;5843.035899076604;5874.823755287348;5874.970625146932;5973.104034394789;5471.671699698031;5472.452754724496;5488.670679759227;5489.149181876815;5516.420775818561;6267.4986001120715;6282.120503129566;6304.338044505353;6337.7781777637565;6347.777827776005;6196.597221180609;6204.100405441095;6221.377862213923;6236.532260080421;6268.404501572343;5305.806193606408;5755.539556835527;6348.079528468438;6355.237371515448;6365.681715914093;6285.905711414241;6304.810855674337;6305.527085468517;6315.873682526232;6340.461060809883;5796.855078623068;6130.061839217998;6177.104319873503;6274.278457977391;6288.308286088435;6222.377762223741;6230.626162430269;6254.249490061222;6259.78090766821;6298.401651843067;6217.347178546368;6233;6238.407351301619;6252.937470625236;6257.56197066201;5750.30996280449;5948.910766338595;5963.701814909324;6040.879182416239;6129.448349648553;6151.96924015377;6221.5333849962335;6235.937640623536;6260.655663938527;6285.96857015712;6083.148359229623;6128.295246046761;6132.5400594956445;6157.0456579230295;6166.630002199882 18:31:10 INFO - PROCESS | 1650 | |1;ext.html;452.9197863096515;475.75498618211606;498.9273062914735;521.976925226556;525.149258201713;36541.90374288772;41236.79381603091;41337.79331103348;41356.37965430521;41401.792991035;41862.58137418625;42030;42628.3605745914;42703;42830.14339713204;8629.568521573927;9661.516924153799;9776.95111524445;9846.1630761385;9879.012098790135;9801.313908026441;9850.310478266489;9873.111419972201;9882.407055576652;9885.703428897144;9253.907460925371;9882.209423246122;9897.554610042529;9901.851472227921;9938.304318697694;9690.806183876319;9804.509774511245;9848.803023939481;9864.062914023229;9878.110970012662;9721.027897210222;9736.805263894683;9736.95131524345;9820.803583928353;9831.31180817343;31920;32241.677583224337;40395.19209615821;40424.59575404238;40529.797351013054;3163.2566346908457;3437.3812713711523;3542.6811586957297;3780.7542509736777;3884.514435695538;29990.100296991124;30445;31424.685753142403;32184.517232241535;32352;2825.364293034051;3076.6639252484642;3267.3628642414737;3269.1500209945584;3293.4071867063917;429840;515651;523602.38198809145;525318;525851;27497.86251068772;65451.672741635986;65478.67260663666;65993;66236.33763662302;34247;34715.65284347175;35389.8230508851;35591.11022224413;35603.82198088993;14764.63088422798;14793.556193314218;14970.700585988438;14983.550493484994;14993.850061499463;12685.365731713377;12750.489980400866;12761.425735841909;12762.17045892014;12781.552645657357;7761.068671759425;7811.843763124706;7816.648250828726;7818.726344577913;7871.252231038042;3264.3308121834966;3282.7045565899184;3283.3761585299194;3288.32589319189;3303.6200836904063;848.5290663681593;923.35826600512;937.5499760115047;1045.843123531461;1111.127764704703;31673.208169795478;32330.191745206557;33460;33674.83162584171;33728.325433491686;930.042056681619;962.7304354780673;1011.7925825205815;1024.8565200871883;1181.2971282087144;13702.314884255748;14028.71942561143;17095.316187352368;17216.397426090025;17272;677609;679173;685851;688007;688895;57967;57977;58592.7070364654;58631.41368586345;58846.11730824041;1356.837179538442;1368.0765483298733;1382.6059573021641;1383.2392184298797;1393.4495874129661;30399.39201215919;30524.236894076937;31400;31878.52182217222;31900;56327.43672563386;58013.709931450074;58073.70963145157;60004.39995600163;60934.695326523084;663076;669072;670237;670356;672167;44148.11133200795;44598.66204013885;44716;45023.0995380084;45121.323180152984;45681.85795355143;48810;49161;49206;49411;39851;40137.39793903035;40562.391564125974;41513;41986.37020444635;30929.558516583962;33687.32625347529;38846.6115338843;40965.18069638531;41075.794621026704;39017.609823901395;39414.40878386769;39457.40813887736;39487;40022.59977400189;34267.4859877107;35263.82368088246;35791.64208357987;35955.46066808948;36180.4572931401;22551.552186752127;26165;26536.587302375065;26784.59823102616;27183.86408067947 18:31:10 INFO - PROCESS | 1650 | |2;jquery.html;319.2561332096216;319.5031725666589;359.58827142921353;388.41737393909136;406.1065655557772;15248;19273.939933303664;20306.898465507653;20412.59174816503;20579.691304630443;19231.615367692673;19279.614407711873;19334.613307733838;19479.610407791835;19895.701564476545;4848.612111031118;5913.319968203668;5924.526037916978;5926.762929482816;5938.554608404387;5508.6970216638065;5761.683107429089;5765.336986246593;5811.157382179603;5816.069428891378;5682.913792156018;5736.139579063132;5755.39568345324;5757.050086735683;5757.309122905257;5650.7174641267975;5764.250647415851;5777.133429985493;5797.217375654275;5810.506106980912;4910.140725373081;5024.346834911475;5118.10433174193;5133.512316329943;5136.8202112925865;24258.029678812825;24265;24277;24385.02459901602;24391.634125488134;2363.1610778173845;2367.5264947010496;2523.4196134888894;2806.466771313444;2909.996051362277;11772;14470.855291447162;14884.776728349083;14943;15442.305096270582;1448.4133925760084;1786.8034516203338;1836.9621164042273;1847.1410793980863;1863.2919490593624;117119;117480.41259793732;119652;120851;121327.18009229869;10143.28996970205;10271.537780799881;10564.049235568682;10565.9471702641;10795.946020269848;12917.547885823951;12940.417681204368;12983.35083245834;13023.218606883427;13050.347482625832;8124.756257312172;8225.177482251727;8365.874511882326;8390.790230244293;8462.788430289293;8484.915150848536;8507.361947853935;8530.274926631306;8586.282743451335;8613.267872230805;6314.0844577536;6409.67951602418;6410.1987251593555;6431.710573024225;6520;1832.496063582499;1836.2104295153213;1854.3218387359461;1854.3880519428556;1869.5886904880904;883.7216276872764;918.9448633082036;951.1819834941945;979.8677178580942;989.42118860466;16797.740169487093;21250;21507.354779356643;21590.676139857915;21602.351929442142;941.2093841173447;961.6778379243032;997.4015590645555;1029.7374169586708;1049.21833234241;10663.360198388122;11270.605528806453;11384.886151138548;11410.714732131763;11450;458069;464480;467156;621975;645708;137575;138044.30977845046;139297.3035134838;145214;149221.50778492293;947.4836214263244;985.8373368394278;991.2615101749099;992.7815880506278;993.9701808945888;16926;18189.81810181881;18687;18695;18712;56661.01686440955;58305;58634.7068264656;59169.40830591639;59561;79203;84496;87503.68744468965;87854.56072719596;87953.68069478835;6760.121184246016;7808.297253247235;7902.446828721934;8043.879341809995;8233.958830206051;9351.85972210431;10281.383117012703;10461.372317660966;12420.316882571546;12659.81010284828;8044.517328960281;9657.855132172883;10061.647842325776;10570.154387648816;10934.507947142238;10181.389116653025;10775.784484310114;10820.242583019428;11071.003609675168;11208.49561769706;10603.363798172135;11270.49282782293;11281.435928203393;11373.658790236306;11565.884341156818;6792.694328755317;7049.718011279491;7160.57036577807;7274.927250727425;8206.917930820615;9035.683751068682;9332.5611119987;10875.836862447228;10888.836667449836;11005.449727513433 18:31:10 INFO - PROCESS | 1650 | |3;mootools.html;1512.9773053404201;1538.753799392097;1718.9140542972857;1811.6376724655065;1822.9088545572718;8106.675732970689;8346.374021948348;8652.653893844246;9191.6782912598;9224.769380765485;8636.438631488949;8936.463812171258;8939.329550283739;9049.909500904989;9062.954685226581;2381.0356805493802;2395.4849707312924;2405.518896220754;2426.817988650849;2432.671589335435;2336.88315584221;2385.1413491143176;2405.6271277951946;2424.3454267347806;2429.1376561320653;2384.6423036544484;2400.7959323457526;2413.613821788514;2413.710354757423;2414.4446777241246;2352.059176329482;2388.34320561846;2400.963985540227;2402.6756387887585;2406.8194885383577;2359.775821296974;2367.419982104378;2368.4197371643886;2395.6646069550275;2401.087586717036;8992.14574615417;9101.726948191565;9128.269738420977;9133.132352426575;9140.54297285133;5311.867203319909;5450.781968721247;5480.561555075585;5485.61600687952;5500.119980803092;3628.6734193922675;3644.3075815594952;3671.430928206132;3702.833372498244;3715;957.7701351675547;1096.331237944853;1096.908575966918;1099.9945000275027;1117.6088369070842;11819.054475642013;11858.28850268978;11921.880781192163;11971.401429928468;11995.16033877629;4654.348391225231;4690.929636055462;4884.511548845158;4901.3383193269165;4904.337914381513;10187.439690816927;10248.48757562119;10248.53881575316;10261.9486902565;10282.845757313646;4911.9754401227765;5216.947830521722;5424.240606315119;5424.267723857308;5468.671879687232;3598.4962105305276;4294.162638285567;4493.146302202571;4798.976005119952;4929.679570827885;3460.39443097462;3661.9450708239397;3971.72197946141;4002.8198731057173;4120.1553681495825;993.5032483758121;1076.3380520979697;1325.827642406481;1330.7737684593642;1339.7789364754706;753.4441378553379;844.7085755414372;908.5638893331238;911.9726408207764;919.4713040002025;5662.207290979266;5791.160281759121;5791.797287094932;5796.913046304308;6117.96941015292;760.5436737957292;815.4862436664863;886.601029536711;903.9728808135767;954.2270760683869;3631.8365673544754;3818.3890577508023;3820.426935959573;3823.5220597425323;3836.2327534492656;10547.419891906018;10816.891831081746;10884.945575272232;10990.450477476094;11110.222284440173;10881.292715973437;10950;10953.014228719294;10953.178511611502;10955.287906286225;6772.966135169391;8324.084350721538;8358.414910956297;8367.246947774729;8483.236508714246;5708.514776244066;5721.456461636138;5732.57005724564;5851.268591426072;5856.209411729533;9882.802343953224;10119.73503312086;10238;10341.276110672481;10373.066424021874;9944;10322.587096516056;10575.15398768112;10585.841212381974;10613.257072005194;6623.039659249478;6810.182778066664;7002.089728335284;7123.821904452223;7255.347018768336;8332.16678332162;8446.239838414573;8507.659693612186;8599.65601375963;8605.741827745178;6354.3963323484195;7426;7575.924240757522;7598.848023039619;7699.538027718355;7424.183339832506;7436.59098749574;7479.027726395534;7480.289372509603;7496.887546686913;6936.653167341512;6938.653067346511;7007.684654190675;7014.158301003912;7015.403690686348;4962.640348423622;4979.875503112451;5084.6440749147205;5096.923546146885;5110.386753589444;4661.463931647904;5025.673331233458;5052.8989420210655;5162.612804039637;5170.3278573785165 18:31:10 INFO - PROCESS | 1650 | |4;prototype.html;296.97327240548344;299.25187032418955;306.13669452144956;307.79070232242066;309.6439095040703;5027.723475208862;5100.821471248507;5551.555875529958;5607.327120745506;5681.488666020057;4353.608175264226;4798.664093513456;5551.139573366125;5551.916721249175;5590.944090559104;4186.4139020536995;4215.208536372045;4228.957710422903;4240.872773816791;4251.978740106295;4088.868470070058;4183.786701856458;4207.621314081732;4248.277792775236;4249.87250382489;4149.087200815816;4151.833926642946;4174.0817020255645;4176.958230417703;4183.874483765492;4164.375343698439;4177.185448837463;4207.747535147901;4211.7051806373565;4211.936820947658;2766.5890395898236;3628.8548458061646;3634.509341238925;3642.1805093853936;3647.777994371889;4489.281714925629;5393.7572809223675;5414.512693857532;5416.91874621881;5441.265429167091;4141.420201171838;4849;4873.975630121827;4881;4881.829135980223;5463.863403414906;5692.601517893749;5782.074868021138;5797.23184428749;5865.768188680382;3533.8586456541707;4037.4751282333405;4038.1318016626565;4039.394090886361;4054.1688953764406;6087.2086628738425;6091.786787462417;6102.816915492543;6121.785737499211;6135.110408990716;3928.626780455852;4028.7582745035393;4049.396037526604;4116;4133.793310334471;4157.48031496063;4177.248095342868;4182.142660754538;4188.518320393194;4207.326827707613;4054.7972601369815;4211.663066954637;4225.218334608107;4825.227963525889;4839.758012099381;5146.459621739664;5567.385458217072;5734.655920644775;5833.125031245348;5918.260217472816;1239.7582471418168;1343.93952272148;1389.3817251323064;1400.2508657868195;1425.6578421178842;839.8740188971581;855.5327613143489;880.8370451466499;881.7134431309722;885.5527958380976;3856.749311294757;3878.9224215516097;4519.5368524153755;4561.407017087758;4573.954260457353;4813.735244561512;4950.727709975914;4965.453800081988;4970.329005584272;5094.038795063927;3820;4539.409876716072;4542.341360502709;4567.6802623816675;4577.359169716243;2246.0678818290226;2301.873396963183;2447.7394142016874;2592.546304396723;2650.4699060187654;4377.921610931305;4483.977580112079;4979.502049795064;5032.345795046694;5134.922976155361;4401.22978478765;4628.629709623222;4673.7429441381055;4819.614430845524;5170.793168273302;4385.824567017284;4403.493598236116;4783.808647654125;5080.390353157644;5097.821576244888;4931.5315045070665;5012.147934851157;5022.146235140108;5045.394552653705;5115.104856649997;4526.615237704832;4628.120657075145;4643.4892161862845;4990.4011518618;5023.296738456692;4390.868273951659;4722.716637001791;5152.227165925141;5175.792968281226;5192.417232109832;3004.173852190665;3122.6877312268593;3384.3738908302043;3389.5254664346517;3417.606975197884;4430.303877889448;4641.375518568474;5001.174571281529;5044.4198917125;5863.384344643751;4689.343491911067;4854.563089321978;5745.885082298247;5851.882962340815;5876.441738035051;5014.272930425141;5354.170103633943;5875.618084824473;5888.583562328254;5898.498627616701;5361.919571206357;5446.564274858081;5704.629199102045;5714.657120572779;5766.855828604318;4861.177058603024;5976.790812321722;5986;5993.850153746192;6005.579609427298;5529.434449207208;5575.665460072409;5820.30156381237;5845.907864494786;5846.824595262149 18:31:10 INFO - PROCESS | 1650 | |5;yui.html;644.7968889799713;749.7750674797556;764.5909438450427;788.9979725748296;812.4881324765399;15270.618234544141;15534.912556121077;15544.300506477208;15716.057036577813;15738.606534836636;12179.147459677826;13998.090124141923;14167.858321416783;14298.642533936656;15882.205889705527;811.9553424561647;826.2150956591232;835.8996920369534;836.3852568362249;840.357126798;840.0507426607925;850.1838235294125;866.9609867555944;874.0385575866528;874.4228808986039;863.2274114667368;886.6763631274571;901.4546199549277;902.1474706402453;905.3526728389201;857.3012994409568;882.2809410330592;888.6756333938131;893.7944272817256;894.4990805149072;542.7476223556026;607.2834055814137;666.210540509493;668.7692746002622;692.0899017791588;15252.771208431883;15260.084394936339;15262.847371526364;15272.38910443581;15313.923430382889;13802.447902083904;14417.639559011004;14498.565043048726;14592.540745925322;14925.402983880631;11510.884891151065;11851;11999;12000.63998080059;12023;3195;3677.0623491009887;3824.2160357127;3832.770033797981;3854.5759966403675;97813.51093244489;107693;110019;113086.86913130846;129408;10732.678019659423;10878.456077196108;10999.780004400027;11372.601958931398;11419.029382502415;22106.22628208005;22211.888940555193;22310.776892231195;22412.77587224107;22429.775702243096;7739.961300193576;8038.356931445471;8101.230383113595;8182.059063207807;8306.293965013041;4036.848672861139;4191.371294305878;4211.599898009684;4225.830966761357;4251.665227275003;3594.4788005739542;3673.3204357194004;3706.499622550975;3716.851325946986;3724.733590579216;669.3741351835952;672.3478226120656;672.865426914619;682.382443888282;687.1719577908608;577.9277590301213;584.5732615190934;615.722924683894;672.2907332763883;676.2459857259219;7405.889526398925;9399.483028433502;9728.832540095234;9838.508074596242;9935.503224838729;602.1299222623355;618.9628622282678;635.4376376906471;643.7231990244146;668.6957434367351;4275.957240427618;4646.568453821125;4737.763111844394;4738.763061846894;4740.786664600101;136593.63406366008;165733.17133414256;166785;172636;175613;140306.298468507;140627;143135;145655;152384;118719.8128018726;121477.99999999824;122462;122841;123587.38206308911;9128.5435728212;9162.587683554122;9202.263818894606;9209.723708288762;9240.676576319796;63036.054459184066;63870;64111.35888641054;64435;66924.33075669376;96251.51874240584;96822.51588742012;102619.48690256501;104543.4772826131;105120;11403.828942566033;11807.940960295144;11815.645530634094;11818.448139743712;11871.525138994344;12750.872491274968;12873.22760634365;12883.871161288642;13779.173249605055;13780.10429322091;12282.38588070575;12330.753384932072;12345.074119440898;12817;12853.16454430459;12173.87826121763;12291.078169137172;12304.507819687113;12404;12830.101892867782;12260.01919846428;12326;12624.684382890502;12752.617421477371;12789.488420463078;8930.687425940061;9124;9261.259099272176;9376.249900008119;9421.152096311365;9064.229540489132;11358.94320528392;11645;11684.47419866125;11866.228695134789 18:31:10 INFO - PROCESS | 1650 | __end_tp_report 18:31:10 INFO - PROCESS | 1650 | __start_cc_report 18:31:10 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,361 18:31:10 INFO - PROCESS | 1650 | __end_cc_report 18:31:10 INFO - PROCESS | 1650 | __startTimestamp1477013470830__endTimestamp 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | ------- Summary: start ------- 18:31:10 INFO - PROCESS | 1650 | Number of tests: 6 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5811.10 Median:6083.15 stddev:663.85 (10.9%) stddev-sans-first:637.52 18:31:10 INFO - PROCESS | 1650 | Values: 3363.7 3397.3 3410.2 3413.2 3441.3 5795.5 5811.9 5826.4 5899.1 5930.3 5874.9 5934.9 5941.2 5961.0 5973.1 5270.1 5304.3 5339.6 5371.5 5414.2 5347.4 5378.5 5384.7 5388.3 5392.5 5239.3 5259.2 5369.9 5394.6 5422.2 4780.8 4813.3 4982.7 5136.6 5292.0 4258.8 5274.2 5290.2 5303.3 5359.1 5687.5 5904.4 5905.7 6001.9 6049.6 6145.0 6206.5 6214.2 6220.5 6230.5 6279.6 6280.9 6303.3 6311.6 6334.0 5862.1 6044.4 6048.4 6055.3 6064.3 6262.0 6312.1 6340.4 6372.0 6376.2 6249.9 6265.4 6282.7 6286.1 6307.4 6155.3 6180.3 6240.4 6310.8 6324.5 6239.5 6283.6 6288.7 6294.9 6318.5 6242.6 6253.8 6281.0 6290.7 6296.7 4898.6 4956.8 4984.6 5012.0 5028.3 3798.9 4425.2 4433.0 4452.3 4486.6 5764.2 5857.5 5881.4 5884.4 5906.2 6106.7 6244.3 6252.8 6277.4 6285.4 5806.6 5843.0 5874.8 5875.0 5973.1 5471.7 5472.5 5488.7 5489.1 5516.4 6267.5 6282.1 6304.3 6337.8 6347.8 6196.6 6204.1 6221.4 6236.5 6268.4 5305.8 5755.5 6348.1 6355.2 6365.7 6285.9 6304.8 6305.5 6315.9 6340.5 5796.9 6130.1 6177.1 6274.3 6288.3 6222.4 6230.6 6254.2 6259.8 6298.4 6217.3 6233.0 6238.4 6252.9 6257.6 5750.3 5948.9 5963.7 6040.9 6129.4 6152.0 6221.5 6235.9 6260.7 6286.0 6083.1 6128.3 6132.5 6157.0 6166.6 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:74124.60 Median:41287.29 stddev:167518.78 (405.7%) stddev-sans-first:167897.39 18:31:10 INFO - PROCESS | 1650 | Values: 452.9 475.8 498.9 522.0 525.1 36541.9 41236.8 41337.8 41356.4 41401.8 41862.6 42030.0 42628.4 42703.0 42830.1 8629.6 9661.5 9777.0 9846.2 9879.0 9801.3 9850.3 9873.1 9882.4 9885.7 9253.9 9882.2 9897.6 9901.9 9938.3 9690.8 9804.5 9848.8 9864.1 9878.1 9721.0 9736.8 9737.0 9820.8 9831.3 31920.0 32241.7 40395.2 40424.6 40529.8 3163.3 3437.4 3542.7 3780.8 3884.5 29990.1 30445.0 31424.7 32184.5 32352.0 2825.4 3076.7 3267.4 3269.2 3293.4 429840.0 515651.0 523602.4 525318.0 525851.0 27497.9 65451.7 65478.7 65993.0 66236.3 34247.0 34715.7 35389.8 35591.1 35603.8 14764.6 14793.6 14970.7 14983.6 14993.9 12685.4 12750.5 12761.4 12762.2 12781.6 7761.1 7811.8 7816.6 7818.7 7871.3 3264.3 3282.7 3283.4 3288.3 3303.6 848.5 923.4 937.5 1045.8 1111.1 31673.2 32330.2 33460.0 33674.8 33728.3 930.0 962.7 1011.8 1024.9 1181.3 13702.3 14028.7 17095.3 17216.4 17272.0 677609.0 679173.0 685851.0 688007.0 688895.0 57967.0 57977.0 58592.7 58631.4 58846.1 1356.8 1368.1 1382.6 1383.2 1393.4 30399.4 30524.2 31400.0 31878.5 31900.0 56327.4 58013.7 58073.7 60004.4 60934.7 663076.0 669072.0 670237.0 670356.0 672167.0 44148.1 44598.7 44716.0 45023.1 45121.3 45681.9 48810.0 49161.0 49206.0 49411.0 39851.0 40137.4 40562.4 41513.0 41986.4 30929.6 33687.3 38846.6 40965.2 41075.8 39017.6 39414.4 39457.4 39487.0 40022.6 34267.5 35263.8 35791.6 35955.5 36180.5 22551.6 26165.0 26536.6 26784.6 27183.9 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:33782.30 Median:2858.23 stddev:91127.31 (3188.2%) stddev-sans-first:91348.31 18:31:10 INFO - PROCESS | 1650 | Values: 319.3 319.5 359.6 388.4 406.1 15248.0 19273.9 20306.9 20412.6 20579.7 19231.6 19279.6 19334.6 19479.6 19895.7 4848.6 5913.3 5924.5 5926.8 5938.6 5508.7 5761.7 5765.3 5811.2 5816.1 5682.9 5736.1 5755.4 5757.1 5757.3 5650.7 5764.3 5777.1 5797.2 5810.5 4910.1 5024.3 5118.1 5133.5 5136.8 24258.0 24265.0 24277.0 24385.0 24391.6 2363.2 2367.5 2523.4 2806.5 2910.0 11772.0 14470.9 14884.8 14943.0 15442.3 1448.4 1786.8 1837.0 1847.1 1863.3 117119.0 117480.4 119652.0 120851.0 121327.2 10143.3 10271.5 10564.0 10565.9 10795.9 12917.5 12940.4 12983.4 13023.2 13050.3 8124.8 8225.2 8365.9 8390.8 8462.8 8484.9 8507.4 8530.3 8586.3 8613.3 6314.1 6409.7 6410.2 6431.7 6520.0 1832.5 1836.2 1854.3 1854.4 1869.6 883.7 918.9 951.2 979.9 989.4 16797.7 21250.0 21507.4 21590.7 21602.4 941.2 961.7 997.4 1029.7 1049.2 10663.4 11270.6 11384.9 11410.7 11450.0 458069.0 464480.0 467156.0 621975.0 645708.0 137575.0 138044.3 139297.3 145214.0 149221.5 947.5 985.8 991.3 992.8 994.0 16926.0 18189.8 18687.0 18695.0 18712.0 56661.0 58305.0 58634.7 59169.4 59561.0 79203.0 84496.0 87503.7 87854.6 87953.7 6760.1 7808.3 7902.4 8043.9 8234.0 9351.9 10281.4 10461.4 12420.3 12659.8 8044.5 9657.9 10061.6 10570.2 10934.5 10181.4 10775.8 10820.2 11071.0 11208.5 10603.4 11270.5 11281.4 11373.7 11565.9 6792.7 7049.7 7160.6 7274.9 8206.9 9035.7 9332.6 10875.8 10888.8 11005.4 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5755.76 Median:4908.16 stddev:3276.94 (66.8%) stddev-sans-first:3270.63 18:31:10 INFO - PROCESS | 1650 | Values: 1513.0 1538.8 1718.9 1811.6 1822.9 8106.7 8346.4 8652.7 9191.7 9224.8 8636.4 8936.5 8939.3 9049.9 9063.0 2381.0 2395.5 2405.5 2426.8 2432.7 2336.9 2385.1 2405.6 2424.3 2429.1 2384.6 2400.8 2413.6 2413.7 2414.4 2352.1 2388.3 2401.0 2402.7 2406.8 2359.8 2367.4 2368.4 2395.7 2401.1 8992.1 9101.7 9128.3 9133.1 9140.5 5311.9 5450.8 5480.6 5485.6 5500.1 3628.7 3644.3 3671.4 3702.8 3715.0 957.8 1096.3 1096.9 1100.0 1117.6 11819.1 11858.3 11921.9 11971.4 11995.2 4654.3 4690.9 4884.5 4901.3 4904.3 10187.4 10248.5 10248.5 10261.9 10282.8 4912.0 5216.9 5424.2 5424.3 5468.7 3598.5 4294.2 4493.1 4799.0 4929.7 3460.4 3661.9 3971.7 4002.8 4120.2 993.5 1076.3 1325.8 1330.8 1339.8 753.4 844.7 908.6 912.0 919.5 5662.2 5791.2 5791.8 5796.9 6118.0 760.5 815.5 886.6 904.0 954.2 3631.8 3818.4 3820.4 3823.5 3836.2 10547.4 10816.9 10884.9 10990.5 11110.2 10881.3 10950.0 10953.0 10953.2 10955.3 6773.0 8324.1 8358.4 8367.2 8483.2 5708.5 5721.5 5732.6 5851.3 5856.2 9882.8 10119.7 10238.0 10341.3 10373.1 9944.0 10322.6 10575.2 10585.8 10613.3 6623.0 6810.2 7002.1 7123.8 7255.3 8332.2 8446.2 8507.7 8599.7 8605.7 6354.4 7426.0 7575.9 7598.8 7699.5 7424.2 7436.6 7479.0 7480.3 7496.9 6936.7 6938.7 7007.7 7014.2 7015.4 4962.6 4979.9 5084.6 5096.9 5110.4 4661.5 5025.7 5052.9 5162.6 5170.3 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4411.90 Median:4753.26 stddev:1352.36 (28.5%) stddev-sans-first:1320.42 18:31:10 INFO - PROCESS | 1650 | Values: 297.0 299.3 306.1 307.8 309.6 5027.7 5100.8 5551.6 5607.3 5681.5 4353.6 4798.7 5551.1 5551.9 5590.9 4186.4 4215.2 4229.0 4240.9 4252.0 4088.9 4183.8 4207.6 4248.3 4249.9 4149.1 4151.8 4174.1 4177.0 4183.9 4164.4 4177.2 4207.7 4211.7 4211.9 2766.6 3628.9 3634.5 3642.2 3647.8 4489.3 5393.8 5414.5 5416.9 5441.3 4141.4 4849.0 4874.0 4881.0 4881.8 5463.9 5692.6 5782.1 5797.2 5865.8 3533.9 4037.5 4038.1 4039.4 4054.2 6087.2 6091.8 6102.8 6121.8 6135.1 3928.6 4028.8 4049.4 4116.0 4133.8 4157.5 4177.2 4182.1 4188.5 4207.3 4054.8 4211.7 4225.2 4825.2 4839.8 5146.5 5567.4 5734.7 5833.1 5918.3 1239.8 1343.9 1389.4 1400.3 1425.7 839.9 855.5 880.8 881.7 885.6 3856.7 3878.9 4519.5 4561.4 4574.0 4813.7 4950.7 4965.5 4970.3 5094.0 3820.0 4539.4 4542.3 4567.7 4577.4 2246.1 2301.9 2447.7 2592.5 2650.5 4377.9 4484.0 4979.5 5032.3 5134.9 4401.2 4628.6 4673.7 4819.6 5170.8 4385.8 4403.5 4783.8 5080.4 5097.8 4931.5 5012.1 5022.1 5045.4 5115.1 4526.6 4628.1 4643.5 4990.4 5023.3 4390.9 4722.7 5152.2 5175.8 5192.4 3004.2 3122.7 3384.4 3389.5 3417.6 4430.3 4641.4 5001.2 5044.4 5863.4 4689.3 4854.6 5745.9 5851.9 5876.4 5014.3 5354.2 5875.6 5888.6 5898.5 5361.9 5446.6 5704.6 5714.7 5766.9 4861.2 5976.8 5986.0 5993.9 6005.6 5529.4 5575.7 5820.3 5845.9 5846.8 18:31:10 INFO - PROCESS | 1650 | 18:31:10 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:26215.70 Median:3711.68 stddev:43514.93 (1172.4%) stddev-sans-first:43594.64 18:31:10 INFO - PROCESS | 1650 | Values: 644.8 749.8 764.6 789.0 812.5 15270.6 15534.9 15544.3 15716.1 15738.6 12179.1 13998.1 14167.9 14298.6 15882.2 812.0 826.2 835.9 836.4 840.4 840.1 850.2 867.0 874.0 874.4 863.2 886.7 901.5 902.1 905.4 857.3 882.3 888.7 893.8 894.5 542.7 607.3 666.2 668.8 692.1 15252.8 15260.1 15262.8 15272.4 15313.9 13802.4 14417.6 14498.6 14592.5 14925.4 11510.9 11851.0 11999.0 12000.6 12023.0 3195.0 3677.1 3824.2 3832.8 3854.6 97813.5 107693.0 110019.0 113086.9 129408.0 10732.7 10878.5 10999.8 11372.6 11419.0 22106.2 22211.9 22310.8 22412.8 22429.8 7740.0 8038.4 8101.2 8182.1 8306.3 4036.8 4191.4 4211.6 4225.8 4251.7 3594.5 3673.3 3706.5 3716.9 3724.7 669.4 672.3 672.9 682.4 687.2 577.9 584.6 615.7 672.3 676.2 7405.9 9399.5 9728.8 9838.5 9935.5 602.1 619.0 635.4 643.7 668.7 4276.0 4646.6 4737.8 4738.8 4740.8 136593.6 165733.2 166785.0 172636.0 175613.0 140306.3 140627.0 143135.0 145655.0 152384.0 118719.8 121478.0 122462.0 122841.0 123587.4 9128.5 9162.6 9202.3 9209.7 9240.7 63036.1 63870.0 64111.4 64435.0 66924.3 96251.5 96822.5 102619.5 104543.5 105120.0 11403.8 11807.9 11815.6 11818.4 11871.5 12750.9 12873.2 12883.9 13779.2 13780.1 12282.4 12330.8 12345.1 12817.0 12853.2 12173.9 12291.1 12304.5 12404.0 12830.1 12260.0 12326.0 12624.7 12752.6 12789.5 8930.7 9124.0 9261.3 9376.2 9421.2 9064.2 11358.9 11645.0 11684.5 11866.2 18:31:10 INFO - PROCESS | 1650 | -------- Summary: end -------- 18:31:10 INFO - PROCESS | 1650 | 18:31:11 INFO - TEST-INFO | 1650: exit 0 18:31:11 INFO - TEST-OK | dromaeo_css | took 1114062ms 18:31:11 INFO - TEST-START | kraken 18:31:11 INFO - operating with platform_type : mac_ 18:31:11 INFO - Initialising browser for kraken test... 18:31:11 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpJZ_sct/profile http://localhost:49273/getInfo.html) 18:31:14 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 18:31:14 INFO - PROCESS | 1663 | colorDepth:24 18:31:14 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 18:31:14 INFO - PROCESS | 1663 | __metrics 18:31:14 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:31:14 INFO - TEST-INFO | 1663: exit 0 18:31:14 INFO - Browser initialized. 18:31:14 INFO - Running cycle 1/1 for kraken test... 18:31:14 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/tmpJZ_sct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:26 INFO - PROCESS | 1665 | RSS: Main: 225390592 18:31:26 INFO - PROCESS | 1665 | 18:31:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:31 INFO - PROCESS | 1665 | RSS: Main: 237879296 18:31:31 INFO - PROCESS | 1665 | 18:31:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 18:31:34 INFO - PROCESS | 1665 | RSS: Main: 245080064 18:31:34 INFO - PROCESS | 1665 | 18:31:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 18:31:38 INFO - PROCESS | 1665 | RSS: Main: 248979456 18:31:38 INFO - PROCESS | 1665 | 18:31:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 18:31:40 INFO - PROCESS | 1665 | RSS: Main: 249356288 18:31:40 INFO - PROCESS | 1665 | 18:31:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:43 INFO - PROCESS | 1665 | RSS: Main: 249491456 18:31:43 INFO - PROCESS | 1665 | 18:31:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 18:31:47 INFO - PROCESS | 1665 | RSS: Main: 251412480 18:31:47 INFO - PROCESS | 1665 | 18:31:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 18:31:50 INFO - PROCESS | 1665 | RSS: Main: 251654144 18:31:50 INFO - PROCESS | 1665 | 18:31:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 18:31:54 INFO - PROCESS | 1665 | RSS: Main: 251752448 18:31:54 INFO - PROCESS | 1665 | 18:31:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:31:56 INFO - PROCESS | 1665 | RSS: Main: 251445248 18:31:56 INFO - PROCESS | 1665 | 18:31:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:31:59 INFO - PROCESS | 1665 | RSS: Main: 251469824 18:31:59 INFO - PROCESS | 1665 | 18:32:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:02 INFO - PROCESS | 1665 | RSS: Main: 251535360 18:32:02 INFO - PROCESS | 1665 | 18:32:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:05 INFO - PROCESS | 1665 | RSS: Main: 251797504 18:32:05 INFO - PROCESS | 1665 | 18:32:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:09 INFO - PROCESS | 1665 | RSS: Main: 251658240 18:32:09 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 18:32:11 INFO - PROCESS | 1665 | RSS: Main: 253358080 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | __start_tp_report 18:32:11 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 18:32:11 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 18:32:11 INFO - PROCESS | 1665 | |i|pagename|runs| 18:32:11 INFO - PROCESS | 1665 | |0;ai-astar;141;118;173;170;100;163;174;172;118;118 18:32:11 INFO - PROCESS | 1665 | |1;audio-beat-detection;144;110;122;132;133;107;98;116;174;140 18:32:11 INFO - PROCESS | 1665 | |2;audio-dft;182;190;192;196;194;193;195;197;215;189 18:32:11 INFO - PROCESS | 1665 | |3;audio-fft;82;59;52;87;85;88;84;50;99;81 18:32:11 INFO - PROCESS | 1665 | |4;audio-oscillator;87;95;120;103;69;71;85;72;69;89 18:32:11 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;109;88;89;102;83;83;106;131;80;86 18:32:11 INFO - PROCESS | 1665 | |6;imaging-darkroom;120;95;96;95;95;105;109;152;138;137 18:32:11 INFO - PROCESS | 1665 | |7;imaging-desaturate;140;123;91;116;150;109;78;142;146;132 18:32:11 INFO - PROCESS | 1665 | |8;json-parse-financial;57;57;56;56;58;59;61;60;58;59 18:32:11 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;70;71;69;82;75;74;69;69;70;71 18:32:11 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;87;94;102;104;103;83;81;85;82;83 18:32:11 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;151;159;164;147;150;152;154;155;213;163 18:32:11 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;162;174;247;184;164;229;233;172;168;172 18:32:11 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;74;91;90;93;81;69;72;82;87;86 18:32:11 INFO - PROCESS | 1665 | __end_tp_report 18:32:11 INFO - PROCESS | 1665 | __start_cc_report 18:32:11 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,939 18:32:11 INFO - PROCESS | 1665 | __end_cc_report 18:32:11 INFO - PROCESS | 1665 | __startTimestamp1477013531713__endTimestamp 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | ------- Summary: start ------- 18:32:11 INFO - PROCESS | 1665 | Number of tests: 14 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:144.70 Median:166.50 stddev:28.93 (17.4%) stddev-sans-first:30.65 18:32:11 INFO - PROCESS | 1665 | Values: 141.0 118.0 173.0 170.0 100.0 163.0 174.0 172.0 118.0 118.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:136.50 stddev:22.11 (16.2%) stddev-sans-first:22.64 18:32:11 INFO - PROCESS | 1665 | Values: 144.0 110.0 122.0 132.0 133.0 107.0 98.0 116.0 174.0 140.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:194.30 Median:194.50 stddev:8.46 (4.3%) stddev-sans-first:7.71 18:32:11 INFO - PROCESS | 1665 | Values: 182.0 190.0 192.0 196.0 194.0 193.0 195.0 197.0 215.0 189.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:76.70 Median:84.50 stddev:16.79 (19.9%) stddev-sans-first:17.69 18:32:11 INFO - PROCESS | 1665 | Values: 82.0 59.0 52.0 87.0 85.0 88.0 84.0 50.0 99.0 81.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:78.50 stddev:16.79 (21.4%) stddev-sans-first:17.80 18:32:11 INFO - PROCESS | 1665 | Values: 87.0 95.0 120.0 103.0 69.0 71.0 85.0 72.0 69.0 89.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:83.00 stddev:16.11 (19.4%) stddev-sans-first:16.35 18:32:11 INFO - PROCESS | 1665 | Values: 109.0 88.0 89.0 102.0 83.0 83.0 106.0 131.0 80.0 86.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:114.20 Median:123.50 stddev:21.34 (17.3%) stddev-sans-first:22.53 18:32:11 INFO - PROCESS | 1665 | Values: 120.0 95.0 96.0 95.0 95.0 105.0 109.0 152.0 138.0 137.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:122.70 Median:144.00 stddev:24.23 (16.8%) stddev-sans-first:24.87 18:32:11 INFO - PROCESS | 1665 | Values: 140.0 123.0 91.0 116.0 150.0 109.0 78.0 142.0 146.0 132.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.50 stddev:1.66 (2.8%) stddev-sans-first:1.72 18:32:11 INFO - PROCESS | 1665 | Values: 57.0 57.0 56.0 56.0 58.0 59.0 61.0 60.0 58.0 59.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.00 stddev:4.08 (5.7%) stddev-sans-first:4.27 18:32:11 INFO - PROCESS | 1665 | Values: 70.0 71.0 69.0 82.0 75.0 74.0 69.0 69.0 70.0 71.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:83.00 stddev:9.43 (11.4%) stddev-sans-first:9.92 18:32:11 INFO - PROCESS | 1665 | Values: 87.0 94.0 102.0 104.0 103.0 83.0 81.0 85.0 82.0 83.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:157.00 stddev:19.16 (12.2%) stddev-sans-first:19.99 18:32:11 INFO - PROCESS | 1665 | Values: 151.0 159.0 164.0 147.0 150.0 152.0 154.0 155.0 213.0 163.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.50 Median:179.00 stddev:32.49 (18.2%) stddev-sans-first:32.78 18:32:11 INFO - PROCESS | 1665 | Values: 162.0 174.0 247.0 184.0 164.0 229.0 233.0 172.0 168.0 172.0 18:32:11 INFO - PROCESS | 1665 | 18:32:11 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.50 Median:86.50 stddev:8.42 (9.7%) stddev-sans-first:8.35 18:32:11 INFO - PROCESS | 1665 | Values: 74.0 91.0 90.0 93.0 81.0 69.0 72.0 82.0 87.0 86.0 18:32:11 INFO - PROCESS | 1665 | -------- Summary: end -------- 18:32:11 INFO - PROCESS | 1665 | 18:32:12 INFO - TEST-INFO | 1665: exit 0 18:32:12 INFO - TEST-OK | kraken | took 61126ms 18:32:12 INFO - SUITE-END | took 1175s 18:32:12 INFO - Completed test suite (00:19:35) 18:32:12 INFO - javascript benchmark 18:32:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7302.985479398283, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.663633636635, 3397.2865698203377, 3410.249745056088, 3413.163774875155, 3441.27733176033, 5795.5073818725405, 5811.941880581193, 5826.417358264182, 5899.085641725539, 5930.288365396148, 5874.9412505874925, 5934.940650593493, 5941.197938278331, 5961.046232602785, 5973.133895585149, 5270.077736396134, 5304.310439642841, 5339.5728341732565, 5371.489708477708, 5414.1608050752, 5347.358317001946, 5378.46215378463, 5384.6769193848295, 5388.299521062257, 5392.514673679368, 5239.345081864767, 5259.211118332242, 5369.9463005370035, 5394.649347792381, 5422.186671999192, 4780.757003179181, 4813.302071199656, 4982.651214414992, 5136.5890728741615, 5291.973540132294, 4258.765767882765, 5274.182501712203, 5290.1800220965815, 5303.337082864642, 5359.115745901921, 5687.544996400278, 5904.350521442638, 5905.704714764244, 6001.879962400728, 6049.637021778663, 6145.047517634774, 6206.472449841769, 6214.161088253073, 6220.533459990474, 6230.501559875199, 6279.591826531307, 6280.937190628127, 6303.3066362700065, 6311.558190926637, 6334.0, 5862.12068189775, 6044.395560444008, 6048.395160483917, 6055.333913269536, 6064.332923378469, 6262.0, 6312.084747711648, 6340.365963403623, 6372.0, 6376.234851817811, 6249.937500624936, 6265.4361107499635, 6282.748690052346, 6286.05709143623, 6307.400796924285, 6155.292141403706, 6180.289266734293, 6240.4071613196675, 6310.810675679737, 6324.525660575383, 6239.469645080128, 6283.622982621057, 6288.654124023223, 6294.937050629526, 6318.494520438354, 6242.563020588606, 6253.812385628438, 6280.9685951569945, 6290.748370065237, 6296.716647750771, 4898.559129678275, 4956.8351437412175, 4984.576311013532, 5011.997600479918, 5028.296038554606, 3798.9430158547643, 4425.181341451842, 4433.046894917608, 4452.287633978548, 4486.64106871456, 5764.221830052889, 5857.47282744555, 5881.441263080001, 5884.382139875337, 5906.202662640574, 6106.73370229429, 6244.250689917239, 6252.843678908063, 6277.403646653652, 6285.43431091204, 5806.622569532967, 5843.035899076604, 5874.823755287348, 5874.970625146932, 5973.104034394789, 5471.671699698031, 5472.452754724496, 5488.670679759227, 5489.149181876815, 5516.420775818561, 6267.4986001120715, 6282.120503129566, 6304.338044505353, 6337.7781777637565, 6347.777827776005, 6196.597221180609, 6204.100405441095, 6221.377862213923, 6236.532260080421, 6268.404501572343, 5305.806193606408, 5755.539556835527, 6348.079528468438, 6355.237371515448, 6365.681715914093, 6285.905711414241, 6304.810855674337, 6305.527085468517, 6315.873682526232, 6340.461060809883, 5796.855078623068, 6130.061839217998, 6177.104319873503, 6274.278457977391, 6288.308286088435, 6222.377762223741, 6230.626162430269, 6254.249490061222, 6259.78090766821, 6298.401651843067, 6217.347178546368, 6233.0, 6238.407351301619, 6252.937470625236, 6257.56197066201, 5750.30996280449, 5948.910766338595, 5963.701814909324, 6040.879182416239, 6129.448349648553, 6151.96924015377, 6221.5333849962335, 6235.937640623536, 6260.655663938527, 6285.96857015712, 6083.148359229623, 6128.295246046761, 6132.5400594956445, 6157.0456579230295, 6166.630002199882], "value": 5767.54138482769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.9197863096515, 475.75498618211606, 498.9273062914735, 521.976925226556, 525.149258201713, 36541.90374288772, 41236.79381603091, 41337.79331103348, 41356.37965430521, 41401.792991035, 41862.58137418625, 42030.0, 42628.3605745914, 42703.0, 42830.14339713204, 8629.568521573927, 9661.516924153799, 9776.95111524445, 9846.1630761385, 9879.012098790135, 9801.313908026441, 9850.310478266489, 9873.111419972201, 9882.407055576652, 9885.703428897144, 9253.907460925371, 9882.209423246122, 9897.554610042529, 9901.851472227921, 9938.304318697694, 9690.806183876319, 9804.509774511245, 9848.803023939481, 9864.062914023229, 9878.110970012662, 9721.027897210222, 9736.805263894683, 9736.95131524345, 9820.803583928353, 9831.31180817343, 31920.0, 32241.677583224337, 40395.19209615821, 40424.59575404238, 40529.797351013054, 3163.2566346908457, 3437.3812713711523, 3542.6811586957297, 3780.7542509736777, 3884.514435695538, 29990.100296991124, 30445.0, 31424.685753142403, 32184.517232241535, 32352.0, 2825.364293034051, 3076.6639252484642, 3267.3628642414737, 3269.1500209945584, 3293.4071867063917, 429840.0, 515651.0, 523602.38198809145, 525318.0, 525851.0, 27497.86251068772, 65451.672741635986, 65478.67260663666, 65993.0, 66236.33763662302, 34247.0, 34715.65284347175, 35389.8230508851, 35591.11022224413, 35603.82198088993, 14764.63088422798, 14793.556193314218, 14970.700585988438, 14983.550493484994, 14993.850061499463, 12685.365731713377, 12750.489980400866, 12761.425735841909, 12762.17045892014, 12781.552645657357, 7761.068671759425, 7811.843763124706, 7816.648250828726, 7818.726344577913, 7871.252231038042, 3264.3308121834966, 3282.7045565899184, 3283.3761585299194, 3288.32589319189, 3303.6200836904063, 848.5290663681593, 923.35826600512, 937.5499760115047, 1045.843123531461, 1111.127764704703, 31673.208169795478, 32330.191745206557, 33460.0, 33674.83162584171, 33728.325433491686, 930.042056681619, 962.7304354780673, 1011.7925825205815, 1024.8565200871883, 1181.2971282087144, 13702.314884255748, 14028.71942561143, 17095.316187352368, 17216.397426090025, 17272.0, 677609.0, 679173.0, 685851.0, 688007.0, 688895.0, 57967.0, 57977.0, 58592.7070364654, 58631.41368586345, 58846.11730824041, 1356.837179538442, 1368.0765483298733, 1382.6059573021641, 1383.2392184298797, 1393.4495874129661, 30399.39201215919, 30524.236894076937, 31400.0, 31878.52182217222, 31900.0, 56327.43672563386, 58013.709931450074, 58073.70963145157, 60004.39995600163, 60934.695326523084, 663076.0, 669072.0, 670237.0, 670356.0, 672167.0, 44148.11133200795, 44598.66204013885, 44716.0, 45023.0995380084, 45121.323180152984, 45681.85795355143, 48810.0, 49161.0, 49206.0, 49411.0, 39851.0, 40137.39793903035, 40562.391564125974, 41513.0, 41986.37020444635, 30929.558516583962, 33687.32625347529, 38846.6115338843, 40965.18069638531, 41075.794621026704, 39017.609823901395, 39414.40878386769, 39457.40813887736, 39487.0, 40022.59977400189, 34267.4859877107, 35263.82368088246, 35791.64208357987, 35955.46066808948, 36180.4572931401, 22551.552186752127, 26165.0, 26536.587302375065, 26784.59823102616, 27183.86408067947], "value": 19338.02323484709, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.2561332096216, 319.5031725666589, 359.58827142921353, 388.41737393909136, 406.1065655557772, 15248.0, 19273.939933303664, 20306.898465507653, 20412.59174816503, 20579.691304630443, 19231.615367692673, 19279.614407711873, 19334.613307733838, 19479.610407791835, 19895.701564476545, 4848.612111031118, 5913.319968203668, 5924.526037916978, 5926.762929482816, 5938.554608404387, 5508.6970216638065, 5761.683107429089, 5765.336986246593, 5811.157382179603, 5816.069428891378, 5682.913792156018, 5736.139579063132, 5755.39568345324, 5757.050086735683, 5757.309122905257, 5650.7174641267975, 5764.250647415851, 5777.133429985493, 5797.217375654275, 5810.506106980912, 4910.140725373081, 5024.346834911475, 5118.10433174193, 5133.512316329943, 5136.8202112925865, 24258.029678812825, 24265.0, 24277.0, 24385.02459901602, 24391.634125488134, 2363.1610778173845, 2367.5264947010496, 2523.4196134888894, 2806.466771313444, 2909.996051362277, 11772.0, 14470.855291447162, 14884.776728349083, 14943.0, 15442.305096270582, 1448.4133925760084, 1786.8034516203338, 1836.9621164042273, 1847.1410793980863, 1863.2919490593624, 117119.0, 117480.41259793732, 119652.0, 120851.0, 121327.18009229869, 10143.28996970205, 10271.537780799881, 10564.049235568682, 10565.9471702641, 10795.946020269848, 12917.547885823951, 12940.417681204368, 12983.35083245834, 13023.218606883427, 13050.347482625832, 8124.756257312172, 8225.177482251727, 8365.874511882326, 8390.790230244293, 8462.788430289293, 8484.915150848536, 8507.361947853935, 8530.274926631306, 8586.282743451335, 8613.267872230805, 6314.0844577536, 6409.67951602418, 6410.1987251593555, 6431.710573024225, 6520.0, 1832.496063582499, 1836.2104295153213, 1854.3218387359461, 1854.3880519428556, 1869.5886904880904, 883.7216276872764, 918.9448633082036, 951.1819834941945, 979.8677178580942, 989.42118860466, 16797.740169487093, 21250.0, 21507.354779356643, 21590.676139857915, 21602.351929442142, 941.2093841173447, 961.6778379243032, 997.4015590645555, 1029.7374169586708, 1049.21833234241, 10663.360198388122, 11270.605528806453, 11384.886151138548, 11410.714732131763, 11450.0, 458069.0, 464480.0, 467156.0, 621975.0, 645708.0, 137575.0, 138044.30977845046, 139297.3035134838, 145214.0, 149221.50778492293, 947.4836214263244, 985.8373368394278, 991.2615101749099, 992.7815880506278, 993.9701808945888, 16926.0, 18189.81810181881, 18687.0, 18695.0, 18712.0, 56661.01686440955, 58305.0, 58634.7068264656, 59169.40830591639, 59561.0, 79203.0, 84496.0, 87503.68744468965, 87854.56072719596, 87953.68069478835, 6760.121184246016, 7808.297253247235, 7902.446828721934, 8043.879341809995, 8233.958830206051, 9351.85972210431, 10281.383117012703, 10461.372317660966, 12420.316882571546, 12659.81010284828, 8044.517328960281, 9657.855132172883, 10061.647842325776, 10570.154387648816, 10934.507947142238, 10181.389116653025, 10775.784484310114, 10820.242583019428, 11071.003609675168, 11208.49561769706, 10603.363798172135, 11270.49282782293, 11281.435928203393, 11373.658790236306, 11565.884341156818, 6792.694328755317, 7049.718011279491, 7160.57036577807, 7274.927250727425, 8206.917930820615, 9035.683751068682, 9332.5611119987, 10875.836862447228, 10888.836667449836, 11005.449727513433], "value": 9532.379971452347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.9773053404201, 1538.753799392097, 1718.9140542972857, 1811.6376724655065, 1822.9088545572718, 8106.675732970689, 8346.374021948348, 8652.653893844246, 9191.6782912598, 9224.769380765485, 8636.438631488949, 8936.463812171258, 8939.329550283739, 9049.909500904989, 9062.954685226581, 2381.0356805493802, 2395.4849707312924, 2405.518896220754, 2426.817988650849, 2432.671589335435, 2336.88315584221, 2385.1413491143176, 2405.6271277951946, 2424.3454267347806, 2429.1376561320653, 2384.6423036544484, 2400.7959323457526, 2413.613821788514, 2413.710354757423, 2414.4446777241246, 2352.059176329482, 2388.34320561846, 2400.963985540227, 2402.6756387887585, 2406.8194885383577, 2359.775821296974, 2367.419982104378, 2368.4197371643886, 2395.6646069550275, 2401.087586717036, 8992.14574615417, 9101.726948191565, 9128.269738420977, 9133.132352426575, 9140.54297285133, 5311.867203319909, 5450.781968721247, 5480.561555075585, 5485.61600687952, 5500.119980803092, 3628.6734193922675, 3644.3075815594952, 3671.430928206132, 3702.833372498244, 3715.0, 957.7701351675547, 1096.331237944853, 1096.908575966918, 1099.9945000275027, 1117.6088369070842, 11819.054475642013, 11858.28850268978, 11921.880781192163, 11971.401429928468, 11995.16033877629, 4654.348391225231, 4690.929636055462, 4884.511548845158, 4901.3383193269165, 4904.337914381513, 10187.439690816927, 10248.48757562119, 10248.53881575316, 10261.9486902565, 10282.845757313646, 4911.9754401227765, 5216.947830521722, 5424.240606315119, 5424.267723857308, 5468.671879687232, 3598.4962105305276, 4294.162638285567, 4493.146302202571, 4798.976005119952, 4929.679570827885, 3460.39443097462, 3661.9450708239397, 3971.72197946141, 4002.8198731057173, 4120.1553681495825, 993.5032483758121, 1076.3380520979697, 1325.827642406481, 1330.7737684593642, 1339.7789364754706, 753.4441378553379, 844.7085755414372, 908.5638893331238, 911.9726408207764, 919.4713040002025, 5662.207290979266, 5791.160281759121, 5791.797287094932, 5796.913046304308, 6117.96941015292, 760.5436737957292, 815.4862436664863, 886.601029536711, 903.9728808135767, 954.2270760683869, 3631.8365673544754, 3818.3890577508023, 3820.426935959573, 3823.5220597425323, 3836.2327534492656, 10547.419891906018, 10816.891831081746, 10884.945575272232, 10990.450477476094, 11110.222284440173, 10881.292715973437, 10950.0, 10953.014228719294, 10953.178511611502, 10955.287906286225, 6772.966135169391, 8324.084350721538, 8358.414910956297, 8367.246947774729, 8483.236508714246, 5708.514776244066, 5721.456461636138, 5732.57005724564, 5851.268591426072, 5856.209411729533, 9882.802343953224, 10119.73503312086, 10238.0, 10341.276110672481, 10373.066424021874, 9944.0, 10322.587096516056, 10575.15398768112, 10585.841212381974, 10613.257072005194, 6623.039659249478, 6810.182778066664, 7002.089728335284, 7123.821904452223, 7255.347018768336, 8332.16678332162, 8446.239838414573, 8507.659693612186, 8599.65601375963, 8605.741827745178, 6354.3963323484195, 7426.0, 7575.924240757522, 7598.848023039619, 7699.538027718355, 7424.183339832506, 7436.59098749574, 7479.027726395534, 7480.289372509603, 7496.887546686913, 6936.653167341512, 6938.653067346511, 7007.684654190675, 7014.158301003912, 7015.403690686348, 4962.640348423622, 4979.875503112451, 5084.6440749147205, 5096.923546146885, 5110.386753589444, 4661.463931647904, 5025.673331233458, 5052.8989420210655, 5162.612804039637, 5170.3278573785165], "value": 4599.208038607892, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.97327240548344, 299.25187032418955, 306.13669452144956, 307.79070232242066, 309.6439095040703, 5027.723475208862, 5100.821471248507, 5551.555875529958, 5607.327120745506, 5681.488666020057, 4353.608175264226, 4798.664093513456, 5551.139573366125, 5551.916721249175, 5590.944090559104, 4186.4139020536995, 4215.208536372045, 4228.957710422903, 4240.872773816791, 4251.978740106295, 4088.868470070058, 4183.786701856458, 4207.621314081732, 4248.277792775236, 4249.87250382489, 4149.087200815816, 4151.833926642946, 4174.0817020255645, 4176.958230417703, 4183.874483765492, 4164.375343698439, 4177.185448837463, 4207.747535147901, 4211.7051806373565, 4211.936820947658, 2766.5890395898236, 3628.8548458061646, 3634.509341238925, 3642.1805093853936, 3647.777994371889, 4489.281714925629, 5393.7572809223675, 5414.512693857532, 5416.91874621881, 5441.265429167091, 4141.420201171838, 4849.0, 4873.975630121827, 4881.0, 4881.829135980223, 5463.863403414906, 5692.601517893749, 5782.074868021138, 5797.23184428749, 5865.768188680382, 3533.8586456541707, 4037.4751282333405, 4038.1318016626565, 4039.394090886361, 4054.1688953764406, 6087.2086628738425, 6091.786787462417, 6102.816915492543, 6121.785737499211, 6135.110408990716, 3928.626780455852, 4028.7582745035393, 4049.396037526604, 4116.0, 4133.793310334471, 4157.48031496063, 4177.248095342868, 4182.142660754538, 4188.518320393194, 4207.326827707613, 4054.7972601369815, 4211.663066954637, 4225.218334608107, 4825.227963525889, 4839.758012099381, 5146.459621739664, 5567.385458217072, 5734.655920644775, 5833.125031245348, 5918.260217472816, 1239.7582471418168, 1343.93952272148, 1389.3817251323064, 1400.2508657868195, 1425.6578421178842, 839.8740188971581, 855.5327613143489, 880.8370451466499, 881.7134431309722, 885.5527958380976, 3856.749311294757, 3878.9224215516097, 4519.5368524153755, 4561.407017087758, 4573.954260457353, 4813.735244561512, 4950.727709975914, 4965.453800081988, 4970.329005584272, 5094.038795063927, 3820.0, 4539.409876716072, 4542.341360502709, 4567.6802623816675, 4577.359169716243, 2246.0678818290226, 2301.873396963183, 2447.7394142016874, 2592.546304396723, 2650.4699060187654, 4377.921610931305, 4483.977580112079, 4979.502049795064, 5032.345795046694, 5134.922976155361, 4401.22978478765, 4628.629709623222, 4673.7429441381055, 4819.614430845524, 5170.793168273302, 4385.824567017284, 4403.493598236116, 4783.808647654125, 5080.390353157644, 5097.821576244888, 4931.5315045070665, 5012.147934851157, 5022.146235140108, 5045.394552653705, 5115.104856649997, 4526.615237704832, 4628.120657075145, 4643.4892161862845, 4990.4011518618, 5023.296738456692, 4390.868273951659, 4722.716637001791, 5152.227165925141, 5175.792968281226, 5192.417232109832, 3004.173852190665, 3122.6877312268593, 3384.3738908302043, 3389.5254664346517, 3417.606975197884, 4430.303877889448, 4641.375518568474, 5001.174571281529, 5044.4198917125, 5863.384344643751, 4689.343491911067, 4854.563089321978, 5745.885082298247, 5851.882962340815, 5876.441738035051, 5014.272930425141, 5354.170103633943, 5875.618084824473, 5888.583562328254, 5898.498627616701, 5361.919571206357, 5446.564274858081, 5704.629199102045, 5714.657120572779, 5766.855828604318, 4861.177058603024, 5976.790812321722, 5986.0, 5993.850153746192, 6005.579609427298, 5529.434449207208, 5575.665460072409, 5820.30156381237, 5845.907864494786, 5846.824595262149], "value": 3985.33843042741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.7968889799713, 749.7750674797556, 764.5909438450427, 788.9979725748296, 812.4881324765399, 15270.618234544141, 15534.912556121077, 15544.300506477208, 15716.057036577813, 15738.606534836636, 12179.147459677826, 13998.090124141923, 14167.858321416783, 14298.642533936656, 15882.205889705527, 811.9553424561647, 826.2150956591232, 835.8996920369534, 836.3852568362249, 840.357126798, 840.0507426607925, 850.1838235294125, 866.9609867555944, 874.0385575866528, 874.4228808986039, 863.2274114667368, 886.6763631274571, 901.4546199549277, 902.1474706402453, 905.3526728389201, 857.3012994409568, 882.2809410330592, 888.6756333938131, 893.7944272817256, 894.4990805149072, 542.7476223556026, 607.2834055814137, 666.210540509493, 668.7692746002622, 692.0899017791588, 15252.771208431883, 15260.084394936339, 15262.847371526364, 15272.38910443581, 15313.923430382889, 13802.447902083904, 14417.639559011004, 14498.565043048726, 14592.540745925322, 14925.402983880631, 11510.884891151065, 11851.0, 11999.0, 12000.63998080059, 12023.0, 3195.0, 3677.0623491009887, 3824.2160357127, 3832.770033797981, 3854.5759966403675, 97813.51093244489, 107693.0, 110019.0, 113086.86913130846, 129408.0, 10732.678019659423, 10878.456077196108, 10999.780004400027, 11372.601958931398, 11419.029382502415, 22106.22628208005, 22211.888940555193, 22310.776892231195, 22412.77587224107, 22429.775702243096, 7739.961300193576, 8038.356931445471, 8101.230383113595, 8182.059063207807, 8306.293965013041, 4036.848672861139, 4191.371294305878, 4211.599898009684, 4225.830966761357, 4251.665227275003, 3594.4788005739542, 3673.3204357194004, 3706.499622550975, 3716.851325946986, 3724.733590579216, 669.3741351835952, 672.3478226120656, 672.865426914619, 682.382443888282, 687.1719577908608, 577.9277590301213, 584.5732615190934, 615.722924683894, 672.2907332763883, 676.2459857259219, 7405.889526398925, 9399.483028433502, 9728.832540095234, 9838.508074596242, 9935.503224838729, 602.1299222623355, 618.9628622282678, 635.4376376906471, 643.7231990244146, 668.6957434367351, 4275.957240427618, 4646.568453821125, 4737.763111844394, 4738.763061846894, 4740.786664600101, 136593.63406366008, 165733.17133414256, 166785.0, 172636.0, 175613.0, 140306.298468507, 140627.0, 143135.0, 145655.0, 152384.0, 118719.8128018726, 121477.99999999824, 122462.0, 122841.0, 123587.38206308911, 9128.5435728212, 9162.587683554122, 9202.263818894606, 9209.723708288762, 9240.676576319796, 63036.054459184066, 63870.0, 64111.35888641054, 64435.0, 66924.33075669376, 96251.51874240584, 96822.51588742012, 102619.48690256501, 104543.4772826131, 105120.0, 11403.828942566033, 11807.940960295144, 11815.645530634094, 11818.448139743712, 11871.525138994344, 12750.872491274968, 12873.22760634365, 12883.871161288642, 13779.173249605055, 13780.10429322091, 12282.38588070575, 12330.753384932072, 12345.074119440898, 12817.0, 12853.16454430459, 12173.87826121763, 12291.078169137172, 12304.507819687113, 12404.0, 12830.101892867782, 12260.01919846428, 12326.0, 12624.684382890502, 12752.617421477371, 12789.488420463078, 8930.687425940061, 9124.0, 9261.259099272176, 9376.249900008119, 9421.152096311365, 9064.229540489132, 11358.94320528392, 11645.0, 11684.47419866125, 11866.228695134789], "value": 7784.030472980034, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1616.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 173.0, 170.0, 100.0, 163.0, 174.0, 172.0, 118.0, 118.0], "value": 144.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 122.0, 132.0, 133.0, 107.0, 98.0, 116.0, 174.0, 140.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 190.0, 192.0, 196.0, 194.0, 193.0, 195.0, 197.0, 215.0, 189.0], "value": 194.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 52.0, 87.0, 85.0, 88.0, 84.0, 50.0, 99.0, 81.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 95.0, 120.0, 103.0, 69.0, 71.0, 85.0, 72.0, 69.0, 89.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 88.0, 89.0, 102.0, 83.0, 83.0, 106.0, 131.0, 80.0, 86.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 95.0, 96.0, 95.0, 95.0, 105.0, 109.0, 152.0, 138.0, 137.0], "value": 114.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 123.0, 91.0, 116.0, 150.0, 109.0, 78.0, 142.0, 146.0, 132.0], "value": 122.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 58.0, 59.0, 61.0, 60.0, 58.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 82.0, 75.0, 74.0, 69.0, 69.0, 70.0, 71.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 94.0, 102.0, 104.0, 103.0, 83.0, 81.0, 85.0, 82.0, 83.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 159.0, 164.0, 147.0, 150.0, 152.0, 154.0, 155.0, 213.0, 163.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 174.0, 247.0, 184.0, 164.0, 229.0, 233.0, 172.0, 168.0, 172.0], "value": 190.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 91.0, 90.0, 93.0, 81.0, 69.0, 72.0, 82.0, 87.0, 86.0], "value": 82.5, "unit": "score"}]}]} 18:32:12 INFO - Return code: 0 18:32:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:13 ERROR - # TBPL SUCCESS # 18:32:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:13 INFO - 2016-10-20 18:32:13.027 screenresolution[1670:10831] starting screenresolution argv=screenresolution get 18:32:13 INFO - 2016-10-20 18:32:13.030 screenresolution[1670:10831] Display 0: 1600x1200x32@60 18:32:13 INFO - 2016-10-20 18:32:13.036 screenresolution[1671:10834] starting screenresolution argv=screenresolution list 18:32:13 INFO - Available Modes on Display 0 18:32:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:13 INFO - Intel Iris: 18:32:13 INFO - Chipset Model: Intel Iris 18:32:13 INFO - Type: GPU 18:32:13 INFO - Bus: Built-In 18:32:13 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:13 INFO - Vendor: Intel (0x8086) 18:32:13 INFO - Device ID: 0x0a2e 18:32:13 INFO - Revision ID: 0x0009 18:32:13 INFO - Displays: 18:32:13 INFO - Display: 18:32:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:13 INFO - Display Serial Number: 1600x1200 60 18:32:13 INFO - Main Display: Yes 18:32:13 INFO - Mirror: Off 18:32:13 INFO - Online: Yes 18:32:13 INFO - Rotation: Supported 18:32:13 INFO - Return code: 0 18:32:13 INFO - Running post-action listener: _resource_record_post_action 18:32:13 INFO - [mozharness: 2016-10-21 01:32:13.269794Z] Finished run-tests step (success) 18:32:13 INFO - Running post-run listener: _resource_record_post_run 18:32:13 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 36360192; Write bytes: 667345408; Read time: 232; Write time: 1962 18:32:13 INFO - TinderboxPrint: CPU usage
54.3% 18:32:13 INFO - TinderboxPrint: I/O read bytes / time
36,360,192 / 232 18:32:13 INFO - TinderboxPrint: I/O write bytes / time
667,345,408 / 1,962 18:32:13 INFO - TinderboxPrint: CPU idle
2,207.8 (45.7%) 18:32:13 INFO - TinderboxPrint: CPU system
971.1 (20.1%) 18:32:13 INFO - TinderboxPrint: CPU user
1,654.8 (34.2%) 18:32:13 INFO - TinderboxPrint: Swap in / out
400,121,856 / 0 18:32:13 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356573696; Write bytes: 356174848; Read time: 27408; Write time: 753 18:32:13 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34455552; Write bytes: 300148224; Read time: 214; Write time: 1173 18:32:13 INFO - Running post-run listener: _upload_blobber_files 18:32:13 INFO - Blob upload gear active. 18:32:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:14 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:15 INFO - (blobuploader) - INFO - Done attempting. 18:32:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:32:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:32:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:16 INFO - (blobuploader) - INFO - Done attempting. 18:32:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:19 INFO - (blobuploader) - INFO - Done attempting. 18:32:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:19 INFO - Return code: 0 18:32:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/112195e3b10f29ba15b2a39de55252b175f849cd502d161da9d2f565ac2ee7806dcebc2d318346299404d87f0076260b3ed0f80c461b9dbfbcace036645c6c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee80fbacfbb04c09400eb8f701a91b449e4e45bb2d3a9f9eb614b7eec4310b76aa7a482a152132a7727242146cf1750d74e9fddf6c15c500ea3188c0323f7be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a7dd0d4c59c107555e6457a123d288e44bf154d77cb59157caade69936ae1e9d0ee1ee9407bf78ad802bf32f000bdf59fdfbf1d5a2d5c8fb9737791a82071ae"} 18:32:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:19 INFO - Contents: 18:32:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/112195e3b10f29ba15b2a39de55252b175f849cd502d161da9d2f565ac2ee7806dcebc2d318346299404d87f0076260b3ed0f80c461b9dbfbcace036645c6c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee80fbacfbb04c09400eb8f701a91b449e4e45bb2d3a9f9eb614b7eec4310b76aa7a482a152132a7727242146cf1750d74e9fddf6c15c500ea3188c0323f7be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a7dd0d4c59c107555e6457a123d288e44bf154d77cb59157caade69936ae1e9d0ee1ee9407bf78ad802bf32f000bdf59fdfbf1d5a2d5c8fb9737791a82071ae"} 18:32:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:19 INFO - Copying logs to upload dir... 18:32:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.586688 ========= master_lag: 3.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-20 18:32:22.173973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 18:32:22.178312) ========= 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.q1CXifHa7X/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.ujBvoCfpvm/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/112195e3b10f29ba15b2a39de55252b175f849cd502d161da9d2f565ac2ee7806dcebc2d318346299404d87f0076260b3ed0f80c461b9dbfbcace036645c6c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee80fbacfbb04c09400eb8f701a91b449e4e45bb2d3a9f9eb614b7eec4310b76aa7a482a152132a7727242146cf1750d74e9fddf6c15c500ea3188c0323f7be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a7dd0d4c59c107555e6457a123d288e44bf154d77cb59157caade69936ae1e9d0ee1ee9407bf78ad802bf32f000bdf59fdfbf1d5a2d5c8fb9737791a82071ae"} build_url:https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010933 build_url: 'https://queue.taskcluster.net/v1/task/FEILhxPDQ8yENz0fE881sw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/112195e3b10f29ba15b2a39de55252b175f849cd502d161da9d2f565ac2ee7806dcebc2d318346299404d87f0076260b3ed0f80c461b9dbfbcace036645c6c9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ee80fbacfbb04c09400eb8f701a91b449e4e45bb2d3a9f9eb614b7eec4310b76aa7a482a152132a7727242146cf1750d74e9fddf6c15c500ea3188c0323f7be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a7dd0d4c59c107555e6457a123d288e44bf154d77cb59157caade69936ae1e9d0ee1ee9407bf78ad802bf32f000bdf59fdfbf1d5a2d5c8fb9737791a82071ae"}' ========= master_lag: 0.43 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 18:32:22.617065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:32:22.617401) ========= 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.q1CXifHa7X/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.ujBvoCfpvm/Listeners TMPDIR=/var/folders/p5/ggm4rr852vvd80d664drn_0m00000w/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.004953 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:32:22.643115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 18:32:22.643410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 18:32:22.643711) ========= ========= Total master_lag: 3.64 =========