builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0087 starttime: 1483658317.39 results: success (0) buildid: 20170105135513 builduid: a813ef5a4e8e49c99a2b9807afcff21a revision: 78de6c8098e439e5dedbd8fb677121008ee8646b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.387702) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.388131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.388419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.461918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.462282) ========= 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.5GuejLZhHF/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.BQHxTg1B3b/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 15:18:37-- 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% 8.15M=0.001s 2017-01-05 15:18:37 (8.15 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.623054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.623352) ========= 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.5GuejLZhHF/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.BQHxTg1B3b/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.020129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:37.672206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 15:18:37.672540) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 78de6c8098e439e5dedbd8fb677121008ee8646b --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-beta --rev 78de6c8098e439e5dedbd8fb677121008ee8646b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5GuejLZhHF/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.BQHxTg1B3b/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 15:18:37,747 truncating revision to first 12 chars 2017-01-05 15:18:37,747 Setting DEBUG logging. 2017-01-05 15:18:37,748 attempt 1/10 2017-01-05 15:18:37,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/78de6c8098e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 15:18:38,863 unpacking tar archive at: mozilla-beta-78de6c8098e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 15:18:39.066639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:39.066944) ========= script_repo_revision: 78de6c8098e439e5dedbd8fb677121008ee8646b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:39.067334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:39.067634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 15:18:39.087553) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-05 15:18:39.087884) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5GuejLZhHF/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.BQHxTg1B3b/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:18:39 INFO - MultiFileLogger online at 20170105 15:18:39 in /builds/slave/test 15:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:39 INFO - {'append_to_log': False, 15:18:39 INFO - 'base_work_dir': '/builds/slave/test', 15:18:39 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:39 INFO - 'branch': 'Mozilla-Beta', 15:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:39 INFO - 'config_files': ('talos/mac_config.py',), 15:18:39 INFO - 'default_actions': ('clobber', 15:18:39 INFO - 'read-buildbot-config', 15:18:39 INFO - 'download-and-extract', 15:18:39 INFO - 'populate-webroot', 15:18:39 INFO - 'create-virtualenv', 15:18:39 INFO - 'install', 15:18:39 INFO - 'run-tests'), 15:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:39 INFO - 'download_minidump_stackwalk': True, 15:18:39 INFO - 'download_symbols': 'ondemand', 15:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:39 INFO - 'installer_path': 'installer.exe', 15:18:39 INFO - 'log_level': 'info', 15:18:39 INFO - 'log_name': 'talos', 15:18:39 INFO - 'log_to_console': True, 15:18:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:18:39 INFO - 'opt_config_files': (), 15:18:39 INFO - 'pip_index': False, 15:18:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:18:39 INFO - 'cmd': ('bash', 15:18:39 INFO - '-c', 15:18:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:18:39 INFO - 'enabled': True, 15:18:39 INFO - 'halt_on_failure': False, 15:18:39 INFO - 'name': 'check_screen_resolution'},), 15:18:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:18:39 INFO - 'cmd': ('bash', 15:18:39 INFO - '-c', 15:18:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:18:39 INFO - 'enabled': True, 15:18:39 INFO - 'halt_on_failure': False, 15:18:39 INFO - 'name': 'check_screen_resolution'},), 15:18:39 INFO - 'run_cmd_checks_enabled': True, 15:18:39 INFO - 'sps_profile': False, 15:18:39 INFO - 'sps_profile_interval': 0, 15:18:39 INFO - 'suite': 'dromaeojs-e10s', 15:18:39 INFO - 'system_bits': '32', 15:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:39 INFO - 'title': 't-yosemite-r7-0087', 15:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:39 INFO - 'use_talos_json': True, 15:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:39 INFO - 'work_dir': 'build'} 15:18:39 INFO - [mozharness: 2017-01-05 23:18:39.284060Z] Running clobber step. 15:18:39 INFO - Running pre-action listener: _resource_record_pre_action 15:18:39 INFO - Running main action method: clobber 15:18:39 INFO - rmtree: /builds/slave/test/build 15:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:40 INFO - Running post-action listener: _resource_record_post_action 15:18:40 INFO - [mozharness: 2017-01-05 23:18:40.340289Z] Finished clobber step (success) 15:18:40 INFO - [mozharness: 2017-01-05 23:18:40.340444Z] Running read-buildbot-config step. 15:18:40 INFO - Running pre-action listener: _resource_record_pre_action 15:18:40 INFO - Running main action method: read_buildbot_config 15:18:40 INFO - Using buildbot properties: 15:18:40 INFO - { 15:18:40 INFO - "project": "", 15:18:40 INFO - "product": "firefox", 15:18:40 INFO - "script_repo_revision": "production", 15:18:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:18:40 INFO - "repository": "", 15:18:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:18:40 INFO - "buildid": "20170105135513", 15:18:40 INFO - "pgo_build": "False", 15:18:40 INFO - "basedir": "/builds/slave/test", 15:18:40 INFO - "buildnumber": 16, 15:18:40 INFO - "slavename": "t-yosemite-r7-0087", 15:18:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:18:40 INFO - "platform": "yosemite_r7", 15:18:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:18:40 INFO - "branch": "mozilla-beta", 15:18:40 INFO - "repo_path": "releases/mozilla-beta", 15:18:40 INFO - "revision": "78de6c8098e439e5dedbd8fb677121008ee8646b", 15:18:40 INFO - "stage_platform": "macosx64", 15:18:40 INFO - "builduid": "a813ef5a4e8e49c99a2b9807afcff21a", 15:18:40 INFO - "slavebuilddir": "test" 15:18:40 INFO - } 15:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 15:18:40 INFO - Running post-action listener: _resource_record_post_action 15:18:40 INFO - [mozharness: 2017-01-05 23:18:40.343726Z] Finished read-buildbot-config step (success) 15:18:40 INFO - [mozharness: 2017-01-05 23:18:40.343860Z] Running download-and-extract step. 15:18:40 INFO - Running pre-action listener: _resource_record_pre_action 15:18:40 INFO - Running main action method: download_and_extract 15:18:40 INFO - mkdir: /builds/slave/test/build/tests 15:18:40 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')]} 15:18:40 INFO - trying https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 15:18:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 15:18:41 INFO - Downloaded 1165 bytes. 15:18:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 15:18:41 INFO - Using the following test package requirements: 15:18:41 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:18:41 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 15:18:41 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 15:18:41 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:18:41 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 15:18:41 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 15:18:41 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 15:18:41 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 15:18:41 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 15:18:41 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 15:18:41 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 15:18:41 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 15:18:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:18:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:18:41 INFO - Fetch https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:18:42 INFO - Expected file size: 16234513 15:18:49 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:18:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 15:18:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 15:18:49 INFO - Fetch https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 15:18:49 INFO - Expected file size: 16234513 15:18:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 15:18:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 15:18:56 INFO - Fetch https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 15:18:57 INFO - Expected file size: 14414089 15:18:58 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')]} 15:18:58 INFO - trying https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 15:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 15:19:01 INFO - Downloaded 86119880 bytes. 15:19:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:19:01 INFO - mkdir: /builds/slave/test/properties 15:19:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:01 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:01 INFO - Contents: 15:19:01 INFO - build_url:https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 15:19:01 INFO - Running post-action listener: _resource_record_post_action 15:19:01 INFO - Running post-action listener: set_extra_try_arguments 15:19:01 INFO - [mozharness: 2017-01-05 23:19:01.966153Z] Finished download-and-extract step (success) 15:19:01 INFO - [mozharness: 2017-01-05 23:19:01.966300Z] Running populate-webroot step. 15:19:01 INFO - Running pre-action listener: _resource_record_pre_action 15:19:01 INFO - Running main action method: populate_webroot 15:19:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:19:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:19:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:19:01 INFO - '--tppagecycles', 15:19:01 INFO - '7'], 15:19:01 INFO - 'tests': ['tsvgm']}}, 15:19:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:19:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:19:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:19:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:19:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['damp', 'tps']}, 15:19:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'tests': ['damp', 'tps']}, 15:19:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['dromaeo_dom']}, 15:19:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['basic_compositor_video']}, 15:19:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:19:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['a11yr', 15:19:01 INFO - 'ts_paint', 15:19:01 INFO - 'tpaint', 15:19:01 INFO - 'sessionrestore', 15:19:01 INFO - 'sessionrestore_no_auto_restore', 15:19:01 INFO - 'tabpaint']}, 15:19:01 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:01 INFO - 'ts_paint', 15:19:01 INFO - 'tpaint', 15:19:01 INFO - 'sessionrestore', 15:19:01 INFO - 'sessionrestore_no_auto_restore', 15:19:01 INFO - 'tabpaint']}, 15:19:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:19:01 INFO - 'ts_paint', 15:19:01 INFO - 'tpaint', 15:19:01 INFO - 'sessionrestore', 15:19:01 INFO - 'sessionrestore_no_auto_restore', 15:19:01 INFO - 'tabpaint']}, 15:19:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:19:01 INFO - 'ts_paint', 15:19:01 INFO - 'tpaint', 15:19:01 INFO - 'sessionrestore', 15:19:01 INFO - 'sessionrestore_no_auto_restore', 15:19:01 INFO - 'tabpaint']}, 15:19:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['a11yr', 15:19:01 INFO - 'ts_paint', 15:19:01 INFO - 'tpaint', 15:19:01 INFO - 'sessionrestore', 15:19:01 INFO - 'sessionrestore_no_auto_restore', 15:19:01 INFO - 'tabpaint']}, 15:19:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['a11yr', 15:19:01 INFO - 'ts_paint', 15:19:01 INFO - 'tpaint', 15:19:01 INFO - 'sessionrestore', 15:19:01 INFO - 'sessionrestore_no_auto_restore', 15:19:01 INFO - 'tabpaint']}, 15:19:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['tsvgx', 15:19:01 INFO - 'tsvgr_opacity', 15:19:01 INFO - 'tart', 15:19:01 INFO - 'tscrollx', 15:19:01 INFO - 'cart']}, 15:19:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:01 INFO - 'tsvgr_opacity', 15:19:01 INFO - 'tart', 15:19:01 INFO - 'tscrollx', 15:19:01 INFO - 'cart']}, 15:19:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'talos_options': ['--disable-e10s'], 15:19:01 INFO - 'tests': ['tp5o']}, 15:19:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'tests': ['tp5o']}, 15:19:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'talos_options': ['--disable-e10s', 15:19:01 INFO - '--xperf_path', 15:19:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:01 INFO - 'tests': ['tp5n']}, 15:19:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:01 INFO - 'talos_options': ['--xperf_path', 15:19:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:01 INFO - 'tests': ['tp5n']}}, 15:19:01 INFO - 'talos.zip': {'path': '', 15:19:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:01 INFO - Running post-action listener: _resource_record_post_action 15:19:01 INFO - [mozharness: 2017-01-05 23:19:01.985083Z] Finished populate-webroot step (success) 15:19:01 INFO - [mozharness: 2017-01-05 23:19:01.985219Z] Running create-virtualenv step. 15:19:01 INFO - Running pre-action listener: _resource_record_pre_action 15:19:01 INFO - Running main action method: create_virtualenv 15:19:01 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:01 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 15:19:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:02 INFO - Using real prefix '/tools/python27' 15:19:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:02 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:05 INFO - Installing pip.................done. 15:19:05 INFO - Return code: 0 15:19:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19:05 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')]} 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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')]} 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:05 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 15:19:05 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 15:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:05 INFO - 'HOME': '/Users/cltbld', 15:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:05 INFO - 'LOGNAME': 'cltbld', 15:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:05 INFO - 'MOZ_NO_REMOTE': '1', 15:19:05 INFO - 'NO_EM_RESTART': '1', 15:19:05 INFO - 'PAGER': '/bin/cat', 15:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:05 INFO - 'PWD': '/builds/slave/test', 15:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:05 INFO - 'SHELL': '/bin/bash', 15:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:05 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:05 INFO - 'USER': 'cltbld', 15:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:05 INFO - 'XPC_FLAGS': '0x0', 15:19:05 INFO - 'XPC_SERVICE_NAME': '0', 15:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:05 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 15:19:05 INFO - Cleaning up... 15:19:05 INFO - Return code: 0 15:19:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:19:05 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')]} 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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')]} 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:05 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 15:19:05 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 15:19:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:05 INFO - 'HOME': '/Users/cltbld', 15:19:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:05 INFO - 'LOGNAME': 'cltbld', 15:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:05 INFO - 'MOZ_NO_REMOTE': '1', 15:19:05 INFO - 'NO_EM_RESTART': '1', 15:19:05 INFO - 'PAGER': '/bin/cat', 15:19:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:05 INFO - 'PWD': '/builds/slave/test', 15:19:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:05 INFO - 'SHELL': '/bin/bash', 15:19:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:05 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:05 INFO - 'USER': 'cltbld', 15:19:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:05 INFO - 'XPC_FLAGS': '0x0', 15:19:05 INFO - 'XPC_SERVICE_NAME': '0', 15:19:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:06 INFO - Downloading/unpacking psutil>=3.1.1 15:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:10 INFO - Installing collected packages: psutil 15:19:10 INFO - Running setup.py install for psutil 15:19:10 INFO - building 'psutil._psutil_osx' extension 15:19:10 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 15:19:10 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 15:19:10 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 15:19:10 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 15:19:10 INFO - building 'psutil._psutil_posix' extension 15:19:10 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 15:19:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:19:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:19:11 INFO - ^ 15:19:11 INFO - 1 warning generated. 15:19:11 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 15:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:11 INFO - Successfully installed psutil 15:19:11 INFO - Cleaning up... 15:19:11 INFO - Return code: 0 15:19:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:11 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:11 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 15:19:11 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 15:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:11 INFO - 'HOME': '/Users/cltbld', 15:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:11 INFO - 'LOGNAME': 'cltbld', 15:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:11 INFO - 'MOZ_NO_REMOTE': '1', 15:19:11 INFO - 'NO_EM_RESTART': '1', 15:19:11 INFO - 'PAGER': '/bin/cat', 15:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:11 INFO - 'PWD': '/builds/slave/test', 15:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:11 INFO - 'SHELL': '/bin/bash', 15:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:11 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:11 INFO - 'USER': 'cltbld', 15:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:11 INFO - 'XPC_FLAGS': '0x0', 15:19:11 INFO - 'XPC_SERVICE_NAME': '0', 15:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:14 INFO - Installing collected packages: mozsystemmonitor 15:19:14 INFO - Running setup.py install for mozsystemmonitor 15:19:14 INFO - Successfully installed mozsystemmonitor 15:19:14 INFO - Cleaning up... 15:19:14 INFO - Return code: 0 15:19:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:14 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')]} 15:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:14 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')]} 15:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:14 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:14 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 15:19:14 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 15:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:14 INFO - 'HOME': '/Users/cltbld', 15:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:14 INFO - 'LOGNAME': 'cltbld', 15:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:14 INFO - 'MOZ_NO_REMOTE': '1', 15:19:14 INFO - 'NO_EM_RESTART': '1', 15:19:14 INFO - 'PAGER': '/bin/cat', 15:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:14 INFO - 'PWD': '/builds/slave/test', 15:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:14 INFO - 'SHELL': '/bin/bash', 15:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:14 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:14 INFO - 'USER': 'cltbld', 15:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:14 INFO - 'XPC_FLAGS': '0x0', 15:19:14 INFO - 'XPC_SERVICE_NAME': '0', 15:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:14 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:14 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 15:19:14 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 15:19:14 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 15:19:14 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 15:19:14 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 15:19:14 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 15:19:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:17 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:17 INFO - warning: no files found matching '*.txt' 15:19:17 INFO - no previously-included directories found matching 'build' 15:19:17 INFO - no previously-included directories found matching 'dist' 15:19:17 INFO - no previously-included directories found matching '.git*' 15:19:17 INFO - Installing collected packages: jsonschema, functools32 15:19:17 INFO - Running setup.py install for functools32 15:19:18 INFO - warning: no files found matching '*.txt' 15:19:18 INFO - no previously-included directories found matching 'build' 15:19:18 INFO - no previously-included directories found matching 'dist' 15:19:18 INFO - no previously-included directories found matching '.git*' 15:19:18 INFO - Successfully installed jsonschema functools32 15:19:18 INFO - Cleaning up... 15:19:18 INFO - Return code: 0 15:19:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:18 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 15:19:18 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 15:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:18 INFO - 'HOME': '/Users/cltbld', 15:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:18 INFO - 'LOGNAME': 'cltbld', 15:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:18 INFO - 'MOZ_NO_REMOTE': '1', 15:19:18 INFO - 'NO_EM_RESTART': '1', 15:19:18 INFO - 'PAGER': '/bin/cat', 15:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:18 INFO - 'PWD': '/builds/slave/test', 15:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:18 INFO - 'SHELL': '/bin/bash', 15:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:18 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:18 INFO - 'USER': 'cltbld', 15:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:18 INFO - 'XPC_FLAGS': '0x0', 15:19:18 INFO - 'XPC_SERVICE_NAME': '0', 15:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:19:18 INFO - Cleaning up... 15:19:18 INFO - Return code: 0 15:19:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:18 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 15:19:18 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 15:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:18 INFO - 'HOME': '/Users/cltbld', 15:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:18 INFO - 'LOGNAME': 'cltbld', 15:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:18 INFO - 'MOZ_NO_REMOTE': '1', 15:19:18 INFO - 'NO_EM_RESTART': '1', 15:19:18 INFO - 'PAGER': '/bin/cat', 15:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:18 INFO - 'PWD': '/builds/slave/test', 15:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:18 INFO - 'SHELL': '/bin/bash', 15:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:18 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:18 INFO - 'USER': 'cltbld', 15:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:18 INFO - 'XPC_FLAGS': '0x0', 15:19:18 INFO - 'XPC_SERVICE_NAME': '0', 15:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:18 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:18 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 15:19:18 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 15:19:18 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 15:19:18 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 15:19:18 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 15:19:18 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 15:19:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:22 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 15:19:22 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 15:19:22 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 15:19:22 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 15:19:22 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 15:19:22 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 15:19:22 INFO - Downloading docopt-0.6.1.tar.gz 15:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:22 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:22 INFO - Running setup.py install for blobuploader 15:19:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:22 INFO - Running setup.py install for requests 15:19:23 INFO - Running setup.py install for docopt 15:19:23 INFO - Successfully installed blobuploader requests docopt 15:19:23 INFO - Cleaning up... 15:19:23 INFO - Return code: 0 15:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:23 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')]} 15:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:23 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')]} 15:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:23 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:23 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 15:19:23 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 15:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:23 INFO - 'HOME': '/Users/cltbld', 15:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:23 INFO - 'LOGNAME': 'cltbld', 15:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:23 INFO - 'MOZ_NO_REMOTE': '1', 15:19:23 INFO - 'NO_EM_RESTART': '1', 15:19:23 INFO - 'PAGER': '/bin/cat', 15:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:23 INFO - 'PWD': '/builds/slave/test', 15:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:23 INFO - 'SHELL': '/bin/bash', 15:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:23 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:23 INFO - 'USER': 'cltbld', 15:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:23 INFO - 'XPC_FLAGS': '0x0', 15:19:23 INFO - 'XPC_SERVICE_NAME': '0', 15:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:23 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-5M88uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:23 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-k03RmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:23 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-8uiRBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-vPu5Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-xvdccd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-9cu9nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-xCkT7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ZOCI_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-_6PsRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VmuLcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-UhmkV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:24 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-tZOYdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-amGUly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-yThCam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-NtZs9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Mq_Esm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:25 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-xIR3uA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:25 INFO - Running setup.py install for manifestparser 15:19:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:25 INFO - Running setup.py install for mozcrash 15:19:25 INFO - Running setup.py install for mozdebug 15:19:25 INFO - Running setup.py install for mozdevice 15:19:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozfile 15:19:26 INFO - Running setup.py install for mozhttpd 15:19:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozinfo 15:19:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozInstall 15:19:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:26 INFO - Running setup.py install for mozleak 15:19:26 INFO - Running setup.py install for mozlog 15:19:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:27 INFO - Running setup.py install for moznetwork 15:19:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:27 INFO - Running setup.py install for mozprocess 15:19:27 INFO - Running setup.py install for mozprofile 15:19:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:27 INFO - Running setup.py install for mozrunner 15:19:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:27 INFO - Running setup.py install for mozscreenshot 15:19:27 INFO - Running setup.py install for moztest 15:19:27 INFO - Running setup.py install for mozversion 15:19:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:28 INFO - Cleaning up... 15:19:28 INFO - Return code: 0 15:19:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:28 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:28 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 15:19:28 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 15:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:28 INFO - 'HOME': '/Users/cltbld', 15:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:28 INFO - 'LOGNAME': 'cltbld', 15:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:28 INFO - 'MOZ_NO_REMOTE': '1', 15:19:28 INFO - 'NO_EM_RESTART': '1', 15:19:28 INFO - 'PAGER': '/bin/cat', 15:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:28 INFO - 'PWD': '/builds/slave/test', 15:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:28 INFO - 'SHELL': '/bin/bash', 15:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:28 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:28 INFO - 'USER': 'cltbld', 15:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:28 INFO - 'XPC_FLAGS': '0x0', 15:19:28 INFO - 'XPC_SERVICE_NAME': '0', 15:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:28 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-21rftj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:28 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-XYWuvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:28 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-8YmLzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:28 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-qRT2Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:28 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-LUI53D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:28 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)) 15:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:28 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-5GOtSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-vfRPh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-bYslf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-qyoqIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-5pKJNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-kt5ZEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-xfvhGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-z03zSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-y6PA4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:29 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)) 15:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:29 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-wPYc57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:30 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)) 15:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-eV1hg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:30 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)) 15:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:30 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-eZnoUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:30 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)) 15:19:30 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)) 15:19:30 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)) 15:19:30 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)) 15:19:30 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)) 15:19:30 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)) 15:19:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:32 INFO - Downloading blessings-1.6.tar.gz 15:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:32 INFO - Installing collected packages: blessings 15:19:32 INFO - Running setup.py install for blessings 15:19:33 INFO - Successfully installed blessings 15:19:33 INFO - Cleaning up... 15:19:33 INFO - Return code: 0 15:19:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:33 INFO - Reading from file tmpfile_stdout 15:19:33 INFO - Current package versions: 15:19:33 INFO - blessings == 1.6 15:19:33 INFO - blobuploader == 1.2.4 15:19:33 INFO - docopt == 0.6.1 15:19:33 INFO - functools32 == 3.2.3-2 15:19:33 INFO - jsonschema == 2.5.1 15:19:33 INFO - manifestparser == 1.1 15:19:33 INFO - mozInstall == 1.12 15:19:33 INFO - mozcrash == 0.17 15:19:33 INFO - mozdebug == 0.1 15:19:33 INFO - mozdevice == 0.48 15:19:33 INFO - mozfile == 1.2 15:19:33 INFO - mozhttpd == 0.7 15:19:33 INFO - mozinfo == 0.9 15:19:33 INFO - mozleak == 0.1 15:19:33 INFO - mozlog == 3.4 15:19:33 INFO - moznetwork == 0.27 15:19:33 INFO - mozprocess == 0.23 15:19:33 INFO - mozprofile == 0.28 15:19:33 INFO - mozrunner == 6.12 15:19:33 INFO - mozscreenshot == 0.1 15:19:33 INFO - mozsystemmonitor == 0.3 15:19:33 INFO - moztest == 0.7 15:19:33 INFO - mozversion == 1.4 15:19:33 INFO - psutil == 3.1.1 15:19:33 INFO - requests == 1.2.3 15:19:33 INFO - wsgiref == 0.1.2 15:19:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:33 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:33 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 15:19:33 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 15:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:33 INFO - 'HOME': '/Users/cltbld', 15:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:33 INFO - 'LOGNAME': 'cltbld', 15:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:33 INFO - 'MOZ_NO_REMOTE': '1', 15:19:33 INFO - 'NO_EM_RESTART': '1', 15:19:33 INFO - 'PAGER': '/bin/cat', 15:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:33 INFO - 'PWD': '/builds/slave/test', 15:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:33 INFO - 'SHELL': '/bin/bash', 15:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:33 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:33 INFO - 'USER': 'cltbld', 15:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:33 INFO - 'XPC_FLAGS': '0x0', 15:19:33 INFO - 'XPC_SERVICE_NAME': '0', 15:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 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)) 15:19:33 INFO - Cleaning up... 15:19:33 INFO - Return code: 0 15:19:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:33 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 0x11041d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110393570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0f9cf4aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, '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.5GuejLZhHF/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.BQHxTg1B3b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 15:19:33 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 15:19:33 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 15:19:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:33 INFO - 'HOME': '/Users/cltbld', 15:19:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:33 INFO - 'LOGNAME': 'cltbld', 15:19:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:33 INFO - 'MOZ_NO_REMOTE': '1', 15:19:33 INFO - 'NO_EM_RESTART': '1', 15:19:33 INFO - 'PAGER': '/bin/cat', 15:19:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:33 INFO - 'PWD': '/builds/slave/test', 15:19:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:33 INFO - 'SHELL': '/bin/bash', 15:19:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:33 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:33 INFO - 'USER': 'cltbld', 15:19:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:33 INFO - 'XPC_FLAGS': '0x0', 15:19:33 INFO - 'XPC_SERVICE_NAME': '0', 15:19:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:33 INFO - Cleaning up... 15:19:33 INFO - Return code: 0 15:19:33 INFO - Running post-action listener: _resource_record_post_action 15:19:33 INFO - Running post-action listener: _start_resource_monitoring 15:19:34 INFO - Starting resource monitoring. 15:19:34 INFO - [mozharness: 2017-01-05 23:19:34.021280Z] Finished create-virtualenv step (success) 15:19:34 INFO - [mozharness: 2017-01-05 23:19:34.022273Z] Running install step. 15:19:34 INFO - Running pre-action listener: _resource_record_pre_action 15:19:34 INFO - Running main action method: install 15:19:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:34 INFO - Reading from file tmpfile_stdout 15:19:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:34 INFO - Reading from file tmpfile_stdout 15:19:34 INFO - Output received: 15:19:34 INFO - Usage: mozinstall [options] installer 15:19:34 INFO - Options: 15:19:34 INFO - -h, --help show this help message and exit 15:19:34 INFO - -d DEST, --destination=DEST 15:19:34 INFO - Directory to install application into. [default: 15:19:34 INFO - "/builds/slave/test"] 15:19:34 INFO - --app=APP Application being installed. [default: firefox] 15:19:34 INFO - mkdir: /builds/slave/test/build/application 15:19:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:19:56 INFO - Reading from file tmpfile_stdout 15:19:56 INFO - Output received: 15:19:56 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:19:56 INFO - Running post-action listener: _resource_record_post_action 15:19:56 INFO - [mozharness: 2017-01-05 23:19:56.792891Z] Finished install step (success) 15:19:56 INFO - [mozharness: 2017-01-05 23:19:56.793034Z] Running run-tests step. 15:19:56 INFO - Running pre-action listener: _resource_record_pre_action 15:19:56 INFO - Running main action method: run_tests 15:19:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:19:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:19:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:19:56 INFO - 2017-01-05 15:19:56.807 screenresolution[1889:13732] starting screenresolution argv=screenresolution get 15:19:56 INFO - 2017-01-05 15:19:56.810 screenresolution[1889:13732] Display 0: 1600x1200x32@60 15:19:56 INFO - 2017-01-05 15:19:56.816 screenresolution[1890:13735] starting screenresolution argv=screenresolution list 15:19:56 INFO - Available Modes on Display 0 15:19:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:19:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:19:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:19:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:19:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:19:57 INFO - Intel Iris: 15:19:57 INFO - Chipset Model: Intel Iris 15:19:57 INFO - Type: GPU 15:19:57 INFO - Bus: Built-In 15:19:57 INFO - VRAM (Dynamic, Max): 1536 MB 15:19:57 INFO - Vendor: Intel (0x8086) 15:19:57 INFO - Device ID: 0x0a2e 15:19:57 INFO - Revision ID: 0x0009 15:19:57 INFO - Displays: 15:19:57 INFO - Display: 15:19:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:19:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:19:57 INFO - Display Serial Number: 1600x1200 60 15:19:57 INFO - Main Display: Yes 15:19:57 INFO - Mirror: Off 15:19:57 INFO - Online: Yes 15:19:57 INFO - Rotation: Supported 15:19:57 INFO - Return code: 0 15:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:57 INFO - Python 2.7.3 15:19:57 INFO - Return code: 0 15:19:57 INFO - grabbing minidump binary from tooltool 15:19: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')]} 15:19:57 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 0x110231d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110229b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:57 INFO - Return code: 0 15:19:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:19:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:19:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 15:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --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 15:19:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5GuejLZhHF/Render', 15:19:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:19:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:19:57 INFO - 'HOME': '/Users/cltbld', 15:19:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:19:57 INFO - 'LOGNAME': 'cltbld', 15:19:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:57 INFO - 'MOZ_NO_REMOTE': '1', 15:19:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:57 INFO - 'NO_EM_RESTART': '1', 15:19:57 INFO - 'PAGER': '/bin/cat', 15:19:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:57 INFO - 'PWD': '/builds/slave/test', 15:19:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:19:57 INFO - 'SHELL': '/bin/bash', 15:19:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BQHxTg1B3b/Listeners', 15:19:57 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 15:19:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:19:57 INFO - 'USER': 'cltbld', 15:19:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:19:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:57 INFO - 'XPC_FLAGS': '0x0', 15:19:57 INFO - 'XPC_SERVICE_NAME': '0', 15:19:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:19:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 15:19:57 INFO - mozversion application_buildid: 20170105135513 15:19:57 INFO - mozversion application_changeset: 78de6c8098e439e5dedbd8fb677121008ee8646b 15:19:57 INFO - mozversion application_display_name: Firefox 15:19:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:57 INFO - mozversion application_name: Firefox 15:19:57 INFO - mozversion application_remotingname: firefox 15:19:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:19:57 INFO - mozversion application_vendor: Mozilla 15:19:57 INFO - mozversion application_version: 51.0 15:19:57 INFO - mozversion platform_buildid: 20170105135513 15:19:57 INFO - mozversion platform_changeset: 78de6c8098e439e5dedbd8fb677121008ee8646b 15:19:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:19:57 INFO - mozversion platform_version: 51.0 15:19:57 INFO - using testdate: 1483658397 15:19:57 INFO - actual date: 1483658397 15:19:57 INFO - starting webserver on 'localhost:49360' 15:19:57 INFO - SUITE-START | Running 2 tests 15:19:57 INFO - TEST-START | dromaeo_css 15:19:57 INFO - operating with platform_type : mac_ 15:19:57 INFO - Initialising browser for dromaeo_css test... 15:19:57 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpzS651l/profile http://localhost:49360/getInfo.html) 15:20:00 INFO - PROCESS | 1900 | __metrics Screen width/height:1600/1200 15:20:00 INFO - PROCESS | 1900 | colorDepth:24 15:20:00 INFO - PROCESS | 1900 | Browser inner width/height: 1024/689 15:20:00 INFO - PROCESS | 1900 | __metrics 15:20:00 ERROR - PROCESS | 1900 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 15:20:01 INFO - TEST-INFO | 1900: exit 0 15:20:01 INFO - Browser initialized. 15:20:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:01 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpzS651l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:12 INFO - PROCESS | 1904 | RSS: Main: 174624768 15:20:12 INFO - PROCESS | 1904 | 15:21:02 INFO - PROCESS | 1904 | 1483658462650 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] 15:23:13 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49360/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49360/tests/dromaeo/cssquery-ext.html) 15:23:15 INFO - PROCESS | 1904 | RSS: Main: 187797504 15:23:15 INFO - PROCESS | 1904 | 15:26:17 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49360/tests/dromaeo/cssquery-ext.html (next: http://localhost:49360/tests/dromaeo/cssquery-jquery.html) 15:26:18 INFO - PROCESS | 1904 | RSS: Main: 198045696 15:26:18 INFO - PROCESS | 1904 | 15:29:19 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49360/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49360/tests/dromaeo/cssquery-mootools.html) 15:29:20 INFO - PROCESS | 1904 | RSS: Main: 199888896 15:29:20 INFO - PROCESS | 1904 | 15:32:22 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49360/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49360/tests/dromaeo/cssquery-prototype.html) 15:32:22 INFO - PROCESS | 1904 | RSS: Main: 204476416 15:32:22 INFO - PROCESS | 1904 | 15:35:25 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49360/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49360/tests/dromaeo/cssquery-yui.html) 15:35:26 INFO - PROCESS | 1904 | RSS: Main: 207499264 15:35:26 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | Cycle 1(1): loaded http://localhost:49360/tests/dromaeo/cssquery-yui.html (next: http://localhost:49360/tests/dromaeo/cssquery-dojo.html) 15:38:28 INFO - PROCESS | 1904 | RSS: Main: 208027648 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | __start_tp_report 15:38:28 INFO - PROCESS | 1904 | _x_x_mozilla_page_load 15:38:28 INFO - PROCESS | 1904 | _x_x_mozilla_page_load_details 15:38:28 INFO - PROCESS | 1904 | |i|pagename|runs| 15:38:28 INFO - PROCESS | 1904 | |0;dojo.html;3442.9483557746635;3557.8398972046257;3563.465480177974;3590.8743193988216;3592.0840185752663;5858.76564937402;5933.199018132551;5944.019236825919;5947.88104237915;5960.582759206857;5922.111683247515;5929;5954.732037058332;5997.160397544337;6013.579049466539;5348.91976620351;5368.758405871726;5404.756785944642;5433.347998240217;5485.533729632986;5425.755840987145;5429.9185512217155;5437.238786569884;5440.265564148848;5464.836054918339;5332.013577488177;5337.5196232339085;5442.102053161224;5455.727213639322;5491.505764481196;5353.7590808413715;5365.114756065244;5383.111786555213;5385.865353366158;5421.484958928895;5322.281491998569;5336.17289320156;5368.355797304349;5409.594280428983;5442.8911421771345;5850.297964244275;5925.4370834770625;6018.15745795589;6071.817845464643;6095.817125486243;6157.2919114301985;6260.71826767792;6297.968510157466;6305.117283580303;6326.5255105867245;6352.364763523657;6368;6377.681115944184;6379.393957574023;6390.105385246069;5877.147813567094;5917.704114794243;6000.489958353502;6066.696665166724;6082.1789058477425;6423.454006409507;6501.609903405811;6530.05314229434;6530.085787989685;6538.869222615521;6284.685765711788;6296.212973378328;6302.905456418157;6312.810615681537;6315.115883776275;6164.6917654117115;6290.433860952537;6372.745090196433;6376.107344971708;6380.361963803675;6181.011038233861;6200.596961197508;6236.469900058455;6286.277078136073;6297.968510157511;6252.843678908063;6262.53031022666;6269.65516896566;6271.905921411182;6287.622742635456;4066.837326506966;4311.913761724748;4979.875503112451;5073.289739436482;5073.720945347967;4501.414816073955;4507.3689683444345;4512.984578469818;4573.611243044312;4577.176108300538;5492.176173573916;5569;5582.86042848932;5752.453516915886;6122.020476723703;6213.1922850029205;6268.09112678659;6325.557210995278;6362.395572420613;6379.266384365857;6009.549283803644;6054.8183554493435;6112.655464441461;6114.11345354921;6116.792316687763;5568.276124103922;5570.387257401682;5589.636673616202;5591.217229587861;5604.4395560444445;5364.980653675789;6491.961286194186;6574.76988305407;6607.504437167232;6626.900596491057;4523.434570678665;6236.34518375564;6253.7185826637;6295.087212354275;6340.682965851781;6523.804285871432;6562.967185164043;6570.77002304917;6578.671066446563;6589.439897608565;6266.6992953209;6280.560360774702;6289.779857704958;6318;6322.589031712924;6218.409251121137;6259.374062593704;6263.997760358321;6274.341194174728;6328.335524770017;4902.901941961212;5512.724363781875;6271.278802937721;6282.780102696383;6283.748650053946;6184.474319682878;6255.24937007562;6270.4670103039925;6287.96856015717;6313.684315784284;4528.43394575678;4542.477615074309;5783.306003279633;6008.54935879802;6132.98805697055;6223.906641400473;6236.189295391751;6236.688165591793;6258.405451482102;6268.091126786681;6017.608855424383;6146.631202127886;6168.228971378578;6168.691565421801;6175.722092505938 15:38:28 INFO - PROCESS | 1904 | |1;ext.html;471.48372532077366;487.536840001998;537.1727539589033;556.2296219735666;573.9598228124033;34223;43092.56907430925;43094.569054309446;43147.56852431479;43155.78422107893;43751.56248437522;44130;44145;44191.99999999992;44247.77876110615;9967.95016024919;9968;10006.19950403966;10156.644517441891;10157.339772914775;7588.051493563305;7917;8712.912870871305;9935;10062.748431289203;9933.801323973516;10024.899751002506;10045.547950342252;10049.547770350351;10067.29528932975;9947.602095916154;10012.04885535873;10016.64941727036;10065.59737610502;10080.697579072566;9819.852702209473;9867.654632087915;9875.90124098757;9957.701268961942;9991.950040249752;41698.37452438216;42211.788941055405;42485.78757106195;42577.78711106456;42706.14587708259;3155.7159855613104;3306.570145881044;3368.6046050806494;3450.9654903450896;4219.156168766228;32232.355352893046;32357.6764232357;32415.6758432415;32852.507212391836;32862;2796.258991367289;3183.1405520509566;3268.96731032689;3290.045886692856;3382.019214427813;502550;504161;504381;506005;506199;66520.66739666367;67060;67406.66296668485;67483;67575;35859.28281434357;36049.27901441957;36070;37954.810225949244;70060.64969675119;17973.820261797475;18009.2796288147;18114.909425452788;18165.455036348932;18176.727349089775;13697.452101915811;13711.794323085162;13823.447062117604;13826.654333641538;13839.584812455643;19877.60244795125;19932.402027939184;20232.89883550602;20420.89789551043;20460.181592736124;6963.338482844122;8254.739377945678;8328.375371847136;8368.163183681705;8384.329253659693;837.7989282572139;850.2602735620051;881.405051590174;971.9757006074764;988.0070529118191;30091;31948.680513195035;32156.517652235234;32224.677753222637;32377.35245295081;941.0003742048148;1084.1760262200785;1127.9492422840829;1139.584051821096;1155.6648571914218;12473.688157796129;16530.338786448647;16631.334746610242;16705.6658866822;16846.57883552921;651347;665435;686836;695170;696768;54030.45969540254;55295.17057244144;55370.723146384815;55578.16632750512;55864.88270234654;1376.5388594820647;1420.6235347632885;1425.4583258361963;1430.4206796247329;1436.2387934394997;30146.857020243875;31832.840835795672;32038.519422209152;32059.800664451937;32196;53169.46830531645;53713;53759.462405375445;53818.46181538134;54008.72995635154;593622;595226;595308;597249;597346;28033.719662803112;28194.577081343385;28260.010899618414;28466.57300140541;28508;49330.26004609862;50418.49581504138;51034.74482627563;51458;51826;33098.66901330956;34443.827780860935;40899.7955010223;41804;42810.57189428191;33598;38430.80784596059;40544.391834121925;40602.39096413615;42180.78909605432;35123.648763512036;39273.80363098166;40122.59877401189;40382.1923561533;40418.59581404148;33521.83239083789;35538;35887.46168807522;36354;36679.449808252364;24418;25241;26549.336266592716;26554.867225663747;27252.863735681196 15:38:28 INFO - PROCESS | 1904 | |2;jquery.html;361.9402798538241;375.5549673636739;382.88704832074535;383.8157684311529;402.0772327508368;19030.429087127373;19487.902560487215;20864;21744;21929.342119736393;20628.17487300506;21050.789492105076;21169.94150292487;21239.787602123975;21633.242836500685;5862.589618726691;5870.970645146779;6056;6150.538709596775;6156.2920264169525;4363.323684828841;4591.931121033187;5450.645708028966;6008.789692360769;6109.969450152766;6671.966640166793;6684.4986626003;6782.423494003016;6796.320367963189;6808.761693340734;6502.9349706503035;6680.565763225375;6691.895837186858;6778.728850845961;6855.383015528626;5758.62568933018;5853.443922827325;5909.8227053188475;5962.433568810956;5995.340512543617;26787.46425071507;26794.732052679417;26813.731862681514;26822.865885670642;27102.728972710218;2494.8004159667366;2529.8988040478357;3103.90688279352;3173.587433633636;3223.8226897520626;15304.923475382664;15762.369505219778;15824.920875395665;16357.263923123488;16545.91727041369;1834.4221570205343;1859.5537071102974;1940.8544359173118;1941.4466876940005;2021.6361055010093;121467;123046.38476807649;127446.36276818557;127738;128775;11110;11133.387663678575;11611;11656.475458604384;11820.468078936468;14207.573772786833;14473.78289325661;14492.565223043115;14520.709585808225;14556.199409032604;8931.687390941286;9143.13140251675;9149.313801464918;9161.167766446737;9256.537173141316;7725.768226953201;9311.953440232755;9329.253659707207;9417.058294170529;9548.331616786758;6894.862102757917;6946.2011868634745;6951.7219311228;6982.965085174542;7053.541519801196;1593.3706186056675;1642.5729310379388;1682.6971145193982;1836.2287839107607;1889.6126294109674;748.5059860492158;859.6260626627437;916.867054277126;1020.1328870460198;1046.6702988558732;21408.357749267547;21564.46088847791;21571.460713481974;21688.674669879965;21861.67207491889;794.6463823598559;841.195635362157;860.3461369359331;861.1388611388611;936.6440752514001;9555.713328600154;11411.42942852854;11453.54185832574;11480.827787583194;11548.191626586058;510298;526097;526248;618714;633345;101632;111255.88744112618;121999.78000220061;122765;124284;981.4160574458186;983;999.6751055906714;1001.2540657210279;1004.3572113847143;18572.628547428707;19016.904915475887;19205.615887681888;19226.711599325743;19280.903595481934;44309.67070987875;51973.96052078862;52449.737751311;53112.73443632757;54718;60295;75210.24789752033;77546.22453775391;78069.43861122859;83625;7943;7983.042034955843;8023.638936247766;8062.234087761653;8104.108548059827;10820.837687434852;12463.875361246271;12477.688057798629;12602.054845886412;12708.618741437771;10823.404712740874;10846.728831779268;10929.18031147683;10991;11281.21031527785;8689.826203476021;10525.36847789135;10838.566457341618;10859.945700271448;10946.507407166537;10948.397838118979;11055.170862185207;11256.437178141225;11493.48279327449;11544.365059921785;6953.548019378724;7011.6494175292055;7379.114506259283;7417.8145546361775;8002.319802816825;9026.81946361056;10784.730381740519;10891.296540165362;11084.862076026739;11129 15:38:28 INFO - PROCESS | 1904 | |3;mootools.html;1428.9428422863082;1535.1863512338462;1742.5817803727102;1887.4998125496754;1900.4868685454928;8267.049289331728;8501.362397820158;8861.689840855572;9525.476098814572;9581.616735330586;8103.311218546416;8790.120987901206;8910.465372077664;9283.53582320883;9307.813843723121;2405.326508577601;2430.440998570321;2430.7812296893276;2431.501542183848;2435.671184390111;2399.0883464283547;2406.097713357491;2407.879606019701;2410.80713542917;2441.5361081394567;2317.339558225906;2396.2212281008656;2432.525657496789;2438.0491608272787;2443.3158715559584;2083.447886310129;2342.461233916209;2355.9293221203393;2393.4375421775867;2398.9880050599722;2017.5763089751024;2034.298167132337;2170.6526955687013;2214.7154650302946;2410.0239403041796;9295;9330.626774928995;9347.97172311052;9430.481323527203;9460;5477.1510415885605;5514.6139770216105;5602.327720673505;5634.408387119375;5638.323401191842;2920.211542883431;3444.7416443766565;3540.4866294387425;3614.945775813365;3676.246369494247;1058.3385384134915;1068.9625863094755;1083.6694808083532;1093.3002878157986;1103.3545375955075;10511.737206569896;10764.138868890548;12376.381180940916;12392;12401.25592464455;4810.6632535722865;4877.878053048702;4887.828925987574;4959.330490383824;4990.950090499121;8542;10061.69814905554;10169.084782369622;10342.948285258526;10352.844707329396;4830.637702172351;5427.267318911975;5469;5470;5489.9569081875115;4623.329617205553;4729.881752956204;5031.949680503221;5034.34553508049;5116.718580478035;4123.422720819088;4165.852514752442;4227.534971153171;4241.448611680524;4273.7008409411665;1325.7679906016601;1326.2241588670736;1337.2511393619604;1344.6436694276024;1350.2506109109538;933.3046880074253;938.4510061614033;944.263474489899;946.1579194516886;967.3180407812475;5802.33273173582;5854.414558544197;5897.3807750185615;5974.462298393166;6142.477889379364;415.60309904041566;447.3558076370017;448.3789950918002;461.3011287898836;461.55459981118383;3957.7229593928723;3995.6603688686205;4017.979910100489;4020.8592699255387;4122.793860306972;9452.291078169164;10584.788304233873;10930.945345273381;10977.012068913837;11123.888761112446;10597.788044239072;10845.51195196218;11032.669019929415;11038.227324087398;11078.113750899909;8393.832123357499;8417.579121043924;8524.744257672155;8592.699255526026;8610.483370997761;5813.186153938536;5901.350851406256;5923.437273459014;5931.495822854933;6014.097885317237;10192.13366863825;10214.846777298495;10217.182625389802;10395.94802025985;10458.895411045793;10108.595656173671;10485.16118710486;10508.474576271003;10604.522796474022;10700.464976751287;7078.327558881898;7281.599512026889;7732.729354472566;7920.089189743023;8078.959605201936;8629.352798540009;8631.093735157718;8788.648454062022;8855.955720221358;8876.846010018657;7602.315791578563;7717.112532058885;7759.7672069838;7773.805654858674;7852.057753069668;7549.50928189666;7672.38620910337;7698.384129269757;7704.345130663956;7724.995750552393;7062.788116356517;7142.321479459443;7183.784486465414;7208.531445456028;7213.567185968649;4945.925811112764;4951.480094590016;4974.801007959641;5114.744262786771;5120.667156634807;5157.020166168416;5170.689758614495;5180.663256888291;5180.844574662766;5207.375114986075 15:38:28 INFO - PROCESS | 1904 | |4;prototype.html;289.1628734812717;296.72404663662786;298.51044287368717;301.18078825594375;306.9232691827043;4969.931464735081;5134.974325128378;5165.225216217569;5525.944740552598;5602;4324.783760811954;5534.529564986981;5547.639403438774;5565.471280228382;5576.525995290405;3974.304496713078;4024.839006439739;4259.765712885783;4309.806058727365;4335.6965012449145;3350.1959529712817;3817.503724515809;4302.075053863418;4304.461942257218;4318.373835793808;3293.127321259868;3547;4057.9043658212263;4124.876253712393;4140.648044916185;3423.657634236569;3758.1544152565452;4095.85664501744;4128.669706423494;4191.434156388879;3005.3388254583956;3059.969400306013;3137.545055966895;3424.3188572284644;3579.355715971124;4682.438107427097;4757.666963312569;5336.573074154058;5388.245645609618;5425.9728701356635;3881.437191607201;4230.386593943892;4426.9817941873225;4660.673752837302;4737.057806299401;5442.911417716433;5542.501174894239;5872.735726892257;5884.264466941632;5908.556858235649;3256.348730253959;3652.7077833773233;3755.8356909358185;3883.4951456310782;3917.373220284769;6202.3797620238065;6244.500439964792;6253;6266.4360207581085;6290.150829637986;3363.5627368442433;3996.580359062257;4017.678585713136;4026.0337518995816;4039.899002524902;3961.3265744823448;4032.475778148822;4050.8177132029127;4060.573639767841;4108.239975604522;4682.859514214579;4707.905841883143;4743.762811859393;4750.548697873696;4772.642051846056;5143.794248230104;5884.293884733774;5924.911126333109;5955.791547295824;6034.577579569388;1283.5315109984788;1341.222091187109;1346.8451128120391;1370.8560601136937;1379.2620947792882;736.3262614707589;899.536738579632;922.5894476957824;923.6674797073048;924.2282693950626;5597.888042239132;5616.241807356037;5632.943975449013;5633.577481688808;5638.577106716931;4868.683535570177;5216.904450065453;5284.497972692588;5636.802711905064;6059.333473317932;4612.861614151514;5050.696958182447;5244.370675518886;5610.719464026783;5658.596040781044;3150.897185984887;3176.8411579420936;3190.330030693534;3240;3245.302260014061;5840.766369345263;5842.532597392198;5899.76400943966;6275.924796849511;6304.527160462983;5659.009673307155;5987.520998320211;6192.368243496496;6227.688615569294;6227.723316720061;6334.936650633527;6361.5546911716665;6367.586106903036;6377.2028496437015;6400.903421810139;5816.73824677882;5852.092925596539;6019.759209631566;6032.526664067711;6157.6613286269685;5679.574031947538;5976.581639285208;5980.611260268069;6029.78895738647;6063.939360606338;5490.684467470455;6129.0999790065225;6148.401415631878;6339.809805705836;6420.1974753155855;3755.2489502099143;3918.3730603103368;3927.6072392760493;3976;3984.521857377133;4306.956930430656;6066.514678825772;6100.75596976116;6111.1444397785235;6113.724882380393;5410.540104091197;5647.463490968352;5852.297724272944;5903.852403689943;5958.910616340845;4423.159599676052;4742.905141897212;5388.551327150705;5756.5822354612;5977.9402205977385;4943.332650092191;5473.644213126134;5584.291618565074;5764.279465066867;5779.734450035717;4824.815621689668;5706.600537962303;5834.899436203048;5885.793997210249;5935.011771056745;5293.497117773805;5749.568782341425;5798.33319168301;5818.214541037075;5865.530757539302 15:38:28 INFO - PROCESS | 1904 | |5;yui.html;708.2174197511749;757.2881491398089;821.5645707774879;823.8434697407496;850.7320194138848;13559.661008474768;14409.71180576389;14462.276886155703;15248.466303679374;15265.694686106284;14600.269986500685;14853.702925941501;14926.626834329147;14937.626559336022;14993.550193494186;680.6834821807859;700.8668353012937;841.364769598955;841.8779277004846;858.7295002074327;835.1189495082685;842.8103676672761;844.8563744163476;845.0366582096384;846.5301757524571;712.6650474277081;788.6293442082213;851.8764779107025;863.8661007543841;871.4292138649195;758.6093162021564;883.1918794303205;888.4891187567142;889.666375109334;890.7773056735816;569.829051284613;621.0994058614981;625.7859752080948;667.4993754683987;670.2325836916751;13349.998750093684;13664.863351366459;14616.415343386252;14724;14892.62768430798;14928;15177.317020734094;15187.924060379628;15238.771418428732;15319.617009574738;11660;11805.58680446189;11809.468573914195;12060.879391206152;12414.317212553306;3892.3577609694366;3972.781497017663;3981.442598036277;4029.254587901218;4075.1849630074103;122626.54746905011;127353.72646273511;128620;129186;130757;11498.885011149781;11769;11804.232724872856;11928.642140735792;11986.92117709393;24249.151279705125;24303.63544546833;24350.756492435205;24545;24623.261302160965;8228.876566851503;8296.170382961656;8334.20825021622;8358.164183581594;8420.4947703138;4301.268784306675;4377.737335759864;4411.779411029435;4587.632989360844;4715.7642117893965;3702.241040586673;3748.1379282765115;3793.1275806564645;3818.6181381861593;3847.7691338519217;663.6980174020905;671.1007250284642;672.7443571442918;675.5575098310615;691.0981169573654;617.3240301869446;638.7618153551128;642.3929386729495;688.721067967474;692.3714965455944;8176.83646327082;8853.247473964786;8975.730728078168;9404.95297523508;9483.688056542735;542.7232111623022;613.5459759777732;675.6722989350161;685.8868286732633;686.5160062156168;4149.170165966819;4626.768661566908;4660.627149828006;4702.482726900038;4721;140401;148498;156113;156246;156753;86243;95712.0428795717;105909.47045264725;114549;140771.29614351862;110421;114660;115424.42287788675;116071.41964290125;119062.8093719069;8617.526036068077;8665.393422460367;8897.866532002156;9129.132732390412;9375.156235938799;47594;57866.71066644808;60457.093143602004;60999.69500152648;62287.37712622997;67031;79194;94743;100031;103995;9178.495182764746;11246.12008856943;11848.644540663794;11859.110566707359;11898.107641926717;12488;13007.024473164362;13026.153300035467;13093.41079651437;13244.801327979896;12008.459619316976;12055.879441205476;12249.755004900031;12348.073894458132;12615.621531354074;11894.762104758029;12182.451789669309;12214.816777748163;12238.632841014783;12691.111622186727;10326.638567650096;10388;11549.538018479503;12050.211709083376;12183.512659493876;9901.653442129491;9923.503824808875;9994.650187243411;10124.797504050026;10180.440075795606;10343.793124137626;10563.94718026405;10565.683029509128;10579.994900484442;10598.099161571045 15:38:28 INFO - PROCESS | 1904 | __end_tp_report 15:38:28 INFO - PROCESS | 1904 | __start_cc_report 15:38:28 INFO - PROCESS | 1904 | _x_x_mozilla_cycle_collect,360 15:38:28 INFO - PROCESS | 1904 | __end_cc_report 15:38:28 INFO - PROCESS | 1904 | __startTimestamp1483659508929__endTimestamp 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | ------- Summary: start ------- 15:38:28 INFO - PROCESS | 1904 | Number of tests: 6 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | [#0] dojo.html Cycles:165 Average:5845.97 Median:6116.79 stddev:675.57 (11.0%) stddev-sans-first:650.81 15:38:28 INFO - PROCESS | 1904 | Values: 3442.9 3557.8 3563.5 3590.9 3592.1 5858.8 5933.2 5944.0 5947.9 5960.6 5922.1 5929.0 5954.7 5997.2 6013.6 5348.9 5368.8 5404.8 5433.3 5485.5 5425.8 5429.9 5437.2 5440.3 5464.8 5332.0 5337.5 5442.1 5455.7 5491.5 5353.8 5365.1 5383.1 5385.9 5421.5 5322.3 5336.2 5368.4 5409.6 5442.9 5850.3 5925.4 6018.2 6071.8 6095.8 6157.3 6260.7 6298.0 6305.1 6326.5 6352.4 6368.0 6377.7 6379.4 6390.1 5877.1 5917.7 6000.5 6066.7 6082.2 6423.5 6501.6 6530.1 6530.1 6538.9 6284.7 6296.2 6302.9 6312.8 6315.1 6164.7 6290.4 6372.7 6376.1 6380.4 6181.0 6200.6 6236.5 6286.3 6298.0 6252.8 6262.5 6269.7 6271.9 6287.6 4066.8 4311.9 4979.9 5073.3 5073.7 4501.4 4507.4 4513.0 4573.6 4577.2 5492.2 5569.0 5582.9 5752.5 6122.0 6213.2 6268.1 6325.6 6362.4 6379.3 6009.5 6054.8 6112.7 6114.1 6116.8 5568.3 5570.4 5589.6 5591.2 5604.4 5365.0 6492.0 6574.8 6607.5 6626.9 4523.4 6236.3 6253.7 6295.1 6340.7 6523.8 6563.0 6570.8 6578.7 6589.4 6266.7 6280.6 6289.8 6318.0 6322.6 6218.4 6259.4 6264.0 6274.3 6328.3 4902.9 5512.7 6271.3 6282.8 6283.7 6184.5 6255.2 6270.5 6288.0 6313.7 4528.4 4542.5 5783.3 6008.5 6133.0 6223.9 6236.2 6236.7 6258.4 6268.1 6017.6 6146.6 6168.2 6168.7 6175.7 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | [#1] ext.html Cycles:180 Average:72651.43 Median:39698.20 stddev:159763.69 (402.4%) stddev-sans-first:160119.96 15:38:28 INFO - PROCESS | 1904 | Values: 471.5 487.5 537.2 556.2 574.0 34223.0 43092.6 43094.6 43147.6 43155.8 43751.6 44130.0 44145.0 44192.0 44247.8 9968.0 9968.0 10006.2 10156.6 10157.3 7588.1 7917.0 8712.9 9935.0 10062.7 9933.8 10024.9 10045.5 10049.5 10067.3 9947.6 10012.0 10016.6 10065.6 10080.7 9819.9 9867.7 9875.9 9957.7 9992.0 41698.4 42211.8 42485.8 42577.8 42706.1 3155.7 3306.6 3368.6 3451.0 4219.2 32232.4 32357.7 32415.7 32852.5 32862.0 2796.3 3183.1 3269.0 3290.0 3382.0 502550.0 504161.0 504381.0 506005.0 506199.0 66520.7 67060.0 67406.7 67483.0 67575.0 35859.3 36049.3 36070.0 37954.8 70060.6 17973.8 18009.3 18114.9 18165.5 18176.7 13697.5 13711.8 13823.4 13826.7 13839.6 19877.6 19932.4 20232.9 20420.9 20460.2 6963.3 8254.7 8328.4 8368.2 8384.3 837.8 850.3 881.4 972.0 988.0 30091.0 31948.7 32156.5 32224.7 32377.4 941.0 1084.2 1127.9 1139.6 1155.7 12473.7 16530.3 16631.3 16705.7 16846.6 651347.0 665435.0 686836.0 695170.0 696768.0 54030.5 55295.2 55370.7 55578.2 55864.9 1376.5 1420.6 1425.5 1430.4 1436.2 30146.9 31832.8 32038.5 32059.8 32196.0 53169.5 53713.0 53759.5 53818.5 54008.7 593622.0 595226.0 595308.0 597249.0 597346.0 28033.7 28194.6 28260.0 28466.6 28508.0 49330.3 50418.5 51034.7 51458.0 51826.0 33098.7 34443.8 40899.8 41804.0 42810.6 33598.0 38430.8 40544.4 40602.4 42180.8 35123.6 39273.8 40122.6 40382.2 40418.6 33521.8 35538.0 35887.5 36354.0 36679.4 24418.0 25241.0 26549.3 26554.9 27252.9 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | [#2] jquery.html Cycles:180 Average:34162.96 Median:26818.30 stddev:94492.52 (352.3%) stddev-sans-first:94723.51 15:38:28 INFO - PROCESS | 1904 | Values: 361.9 375.6 382.9 383.8 402.1 19030.4 19487.9 20864.0 21744.0 21929.3 20628.2 21050.8 21169.9 21239.8 21633.2 5862.6 5871.0 6056.0 6150.5 6156.3 4363.3 4591.9 5450.6 6008.8 6110.0 6672.0 6684.5 6782.4 6796.3 6808.8 6502.9 6680.6 6691.9 6778.7 6855.4 5758.6 5853.4 5909.8 5962.4 5995.3 26787.5 26794.7 26813.7 26822.9 27102.7 2494.8 2529.9 3103.9 3173.6 3223.8 15304.9 15762.4 15824.9 16357.3 16545.9 1834.4 1859.6 1940.9 1941.4 2021.6 121467.0 123046.4 127446.4 127738.0 128775.0 11110.0 11133.4 11611.0 11656.5 11820.5 14207.6 14473.8 14492.6 14520.7 14556.2 8931.7 9143.1 9149.3 9161.2 9256.5 7725.8 9312.0 9329.3 9417.1 9548.3 6894.9 6946.2 6951.7 6983.0 7053.5 1593.4 1642.6 1682.7 1836.2 1889.6 748.5 859.6 916.9 1020.1 1046.7 21408.4 21564.5 21571.5 21688.7 21861.7 794.6 841.2 860.3 861.1 936.6 9555.7 11411.4 11453.5 11480.8 11548.2 510298.0 526097.0 526248.0 618714.0 633345.0 101632.0 111255.9 121999.8 122765.0 124284.0 981.4 983.0 999.7 1001.3 1004.4 18572.6 19016.9 19205.6 19226.7 19280.9 44309.7 51974.0 52449.7 53112.7 54718.0 60295.0 75210.2 77546.2 78069.4 83625.0 7943.0 7983.0 8023.6 8062.2 8104.1 10820.8 12463.9 12477.7 12602.1 12708.6 10823.4 10846.7 10929.2 10991.0 11281.2 8689.8 10525.4 10838.6 10859.9 10946.5 10948.4 11055.2 11256.4 11493.5 11544.4 6953.5 7011.6 7379.1 7417.8 8002.3 9026.8 10784.7 10891.3 11084.9 11129.0 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | [#3] mootools.html Cycles:180 Average:5839.74 Median:4820.65 stddev:3305.73 (68.6%) stddev-sans-first:3298.38 15:38:28 INFO - PROCESS | 1904 | Values: 1428.9 1535.2 1742.6 1887.5 1900.5 8267.0 8501.4 8861.7 9525.5 9581.6 8103.3 8790.1 8910.5 9283.5 9307.8 2405.3 2430.4 2430.8 2431.5 2435.7 2399.1 2406.1 2407.9 2410.8 2441.5 2317.3 2396.2 2432.5 2438.0 2443.3 2083.4 2342.5 2355.9 2393.4 2399.0 2017.6 2034.3 2170.7 2214.7 2410.0 9295.0 9330.6 9348.0 9430.5 9460.0 5477.2 5514.6 5602.3 5634.4 5638.3 2920.2 3444.7 3540.5 3614.9 3676.2 1058.3 1069.0 1083.7 1093.3 1103.4 10511.7 10764.1 12376.4 12392.0 12401.3 4810.7 4877.9 4887.8 4959.3 4991.0 8542.0 10061.7 10169.1 10342.9 10352.8 4830.6 5427.3 5469.0 5470.0 5490.0 4623.3 4729.9 5031.9 5034.3 5116.7 4123.4 4165.9 4227.5 4241.4 4273.7 1325.8 1326.2 1337.3 1344.6 1350.3 933.3 938.5 944.3 946.2 967.3 5802.3 5854.4 5897.4 5974.5 6142.5 415.6 447.4 448.4 461.3 461.6 3957.7 3995.7 4018.0 4020.9 4122.8 9452.3 10584.8 10930.9 10977.0 11123.9 10597.8 10845.5 11032.7 11038.2 11078.1 8393.8 8417.6 8524.7 8592.7 8610.5 5813.2 5901.4 5923.4 5931.5 6014.1 10192.1 10214.8 10217.2 10395.9 10458.9 10108.6 10485.2 10508.5 10604.5 10700.5 7078.3 7281.6 7732.7 7920.1 8079.0 8629.4 8631.1 8788.6 8856.0 8876.8 7602.3 7717.1 7759.8 7773.8 7852.1 7549.5 7672.4 7698.4 7704.3 7725.0 7062.8 7142.3 7183.8 7208.5 7213.6 4945.9 4951.5 4974.8 5114.7 5120.7 5157.0 5170.7 5180.7 5180.8 5207.4 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | [#4] prototype.html Cycles:180 Average:4705.98 Median:5388.40 stddev:1506.79 (28.0%) stddev-sans-first:1474.10 15:38:28 INFO - PROCESS | 1904 | Values: 289.2 296.7 298.5 301.2 306.9 4969.9 5135.0 5165.2 5525.9 5602.0 4324.8 5534.5 5547.6 5565.5 5576.5 3974.3 4024.8 4259.8 4309.8 4335.7 3350.2 3817.5 4302.1 4304.5 4318.4 3293.1 3547.0 4057.9 4124.9 4140.6 3423.7 3758.2 4095.9 4128.7 4191.4 3005.3 3060.0 3137.5 3424.3 3579.4 4682.4 4757.7 5336.6 5388.2 5426.0 3881.4 4230.4 4427.0 4660.7 4737.1 5442.9 5542.5 5872.7 5884.3 5908.6 3256.3 3652.7 3755.8 3883.5 3917.4 6202.4 6244.5 6253.0 6266.4 6290.2 3363.6 3996.6 4017.7 4026.0 4039.9 3961.3 4032.5 4050.8 4060.6 4108.2 4682.9 4707.9 4743.8 4750.5 4772.6 5143.8 5884.3 5924.9 5955.8 6034.6 1283.5 1341.2 1346.8 1370.9 1379.3 736.3 899.5 922.6 923.7 924.2 5597.9 5616.2 5632.9 5633.6 5638.6 4868.7 5216.9 5284.5 5636.8 6059.3 4612.9 5050.7 5244.4 5610.7 5658.6 3150.9 3176.8 3190.3 3240.0 3245.3 5840.8 5842.5 5899.8 6275.9 6304.5 5659.0 5987.5 6192.4 6227.7 6227.7 6334.9 6361.6 6367.6 6377.2 6400.9 5816.7 5852.1 6019.8 6032.5 6157.7 5679.6 5976.6 5980.6 6029.8 6063.9 5490.7 6129.1 6148.4 6339.8 6420.2 3755.2 3918.4 3927.6 3976.0 3984.5 4307.0 6066.5 6100.8 6111.1 6113.7 5410.5 5647.5 5852.3 5903.9 5958.9 4423.2 4742.9 5388.6 5756.6 5977.9 4943.3 5473.6 5584.3 5764.3 5779.7 4824.8 5706.6 5834.9 5885.8 5935.0 5293.5 5749.6 5798.3 5818.2 5865.5 15:38:28 INFO - PROCESS | 1904 | 15:38:28 INFO - PROCESS | 1904 | [#5] yui.html Cycles:180 Average:24645.85 Median:3870.06 stddev:40028.15 (1034.3%) stddev-sans-first:40100.09 15:38:28 INFO - PROCESS | 1904 | Values: 708.2 757.3 821.6 823.8 850.7 13559.7 14409.7 14462.3 15248.5 15265.7 14600.3 14853.7 14926.6 14937.6 14993.6 680.7 700.9 841.4 841.9 858.7 835.1 842.8 844.9 845.0 846.5 712.7 788.6 851.9 863.9 871.4 758.6 883.2 888.5 889.7 890.8 569.8 621.1 625.8 667.5 670.2 13350.0 13664.9 14616.4 14724.0 14892.6 14928.0 15177.3 15187.9 15238.8 15319.6 11660.0 11805.6 11809.5 12060.9 12414.3 3892.4 3972.8 3981.4 4029.3 4075.2 122626.5 127353.7 128620.0 129186.0 130757.0 11498.9 11769.0 11804.2 11928.6 11986.9 24249.2 24303.6 24350.8 24545.0 24623.3 8228.9 8296.2 8334.2 8358.2 8420.5 4301.3 4377.7 4411.8 4587.6 4715.8 3702.2 3748.1 3793.1 3818.6 3847.8 663.7 671.1 672.7 675.6 691.1 617.3 638.8 642.4 688.7 692.4 8176.8 8853.2 8975.7 9405.0 9483.7 542.7 613.5 675.7 685.9 686.5 4149.2 4626.8 4660.6 4702.5 4721.0 140401.0 148498.0 156113.0 156246.0 156753.0 86243.0 95712.0 105909.5 114549.0 140771.3 110421.0 114660.0 115424.4 116071.4 119062.8 8617.5 8665.4 8897.9 9129.1 9375.2 47594.0 57866.7 60457.1 60999.7 62287.4 67031.0 79194.0 94743.0 100031.0 103995.0 9178.5 11246.1 11848.6 11859.1 11898.1 12488.0 13007.0 13026.2 13093.4 13244.8 12008.5 12055.9 12249.8 12348.1 12615.6 11894.8 12182.5 12214.8 12238.6 12691.1 10326.6 10388.0 11549.5 12050.2 12183.5 9901.7 9923.5 9994.7 10124.8 10180.4 10343.8 10563.9 10565.7 10580.0 10598.1 15:38:28 INFO - PROCESS | 1904 | -------- Summary: end -------- 15:38:28 INFO - PROCESS | 1904 | 15:38:29 INFO - TEST-INFO | 1904: exit 0 15:38:29 INFO - TEST-OK | dromaeo_css | took 1112072ms 15:38:29 INFO - TEST-START | kraken 15:38:29 INFO - operating with platform_type : mac_ 15:38:29 INFO - Initialising browser for kraken test... 15:38:29 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpvhlSke/profile http://localhost:49360/getInfo.html) 15:38:31 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 15:38:31 INFO - PROCESS | 1910 | colorDepth:24 15:38:31 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 15:38:31 INFO - PROCESS | 1910 | __metrics 15:38:32 ERROR - PROCESS | 1910 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 15:38:32 INFO - PROCESS | 1910 | [Parent 1910] WARNING: pipe error: Broken pipe: file /builds/slave/m-beta-m64-0000000000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 687 15:38:32 INFO - TEST-INFO | 1910: exit 0 15:38:32 INFO - Browser initialized. 15:38:32 INFO - Running cycle 1/1 for kraken test... 15:38:32 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpvhlSke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:44 INFO - PROCESS | 1913 | RSS: Main: 175513600 15:38:44 INFO - PROCESS | 1913 | 15:38:47 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49360/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:48 INFO - PROCESS | 1913 | RSS: Main: 187252736 15:38:48 INFO - PROCESS | 1913 | 15:38:51 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49360/tests/kraken/driver.html?testName=audio-dft) 15:38:51 INFO - PROCESS | 1913 | RSS: Main: 194732032 15:38:51 INFO - PROCESS | 1913 | 15:38:55 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49360/tests/kraken/driver.html?testName=audio-fft) 15:38:55 INFO - PROCESS | 1913 | RSS: Main: 198225920 15:38:55 INFO - PROCESS | 1913 | 15:38:57 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49360/tests/kraken/driver.html?testName=audio-oscillator) 15:38:58 INFO - PROCESS | 1913 | RSS: Main: 198643712 15:38:58 INFO - PROCESS | 1913 | 15:39:00 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49360/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:00 INFO - PROCESS | 1913 | RSS: Main: 200040448 15:39:00 INFO - PROCESS | 1913 | 15:39:03 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49360/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:04 INFO - PROCESS | 1913 | RSS: Main: 200433664 15:39:04 INFO - PROCESS | 1913 | 15:39:07 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49360/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:07 INFO - PROCESS | 1913 | RSS: Main: 200445952 15:39:07 INFO - PROCESS | 1913 | 15:39:10 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49360/tests/kraken/driver.html?testName=json-parse-financial) 15:39:11 INFO - PROCESS | 1913 | RSS: Main: 200937472 15:39:11 INFO - PROCESS | 1913 | 15:39:12 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49360/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:13 INFO - PROCESS | 1913 | RSS: Main: 200413184 15:39:13 INFO - PROCESS | 1913 | 15:39:15 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:15 INFO - PROCESS | 1913 | RSS: Main: 200593408 15:39:15 INFO - PROCESS | 1913 | 15:39:18 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:18 INFO - PROCESS | 1913 | RSS: Main: 200589312 15:39:18 INFO - PROCESS | 1913 | 15:39:21 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:22 INFO - PROCESS | 1913 | RSS: Main: 200663040 15:39:22 INFO - PROCESS | 1913 | 15:39:25 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:25 INFO - PROCESS | 1913 | RSS: Main: 201089024 15:39:25 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49360/tests/kraken/driver.html?testName=ai-astar) 15:39:27 INFO - PROCESS | 1913 | RSS: Main: 202399744 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | __start_tp_report 15:39:27 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 15:39:27 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 15:39:27 INFO - PROCESS | 1913 | |i|pagename|runs| 15:39:27 INFO - PROCESS | 1913 | |0;ai-astar;106;117;119;128;179;119;132;173;118;117 15:39:27 INFO - PROCESS | 1913 | |1;audio-beat-detection;136;113;109;171;141;138;112;114;139;95 15:39:27 INFO - PROCESS | 1913 | |2;audio-dft;198;202;228;285;200;195;195;195;192;199 15:39:27 INFO - PROCESS | 1913 | |3;audio-fft;87;78;77;82;59;61;60;63;77;59 15:39:27 INFO - PROCESS | 1913 | |4;audio-oscillator;86;71;88;74;69;70;86;69;71;87 15:39:27 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;90;89;107;89;92;87;92;89;90;88 15:39:27 INFO - PROCESS | 1913 | |6;imaging-darkroom;164;100;100;99;113;99;172;99;101;101 15:39:27 INFO - PROCESS | 1913 | |7;imaging-desaturate;90;93;90;90;102;91;93;91;89;91 15:39:27 INFO - PROCESS | 1913 | |8;json-parse-financial;56;55;55;54;59;60;58;58;65;72 15:39:27 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;66;68;73;83;76;74;68;68;70;73 15:39:27 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;84;85;82;83;83;79;92;104;81;89 15:39:27 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;136;142;146;138;136;160;157;138;166;150 15:39:27 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;165;166;161;160;166;170;170;164;212;222 15:39:27 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;70;72;89;82;68;66;68;75;87;89 15:39:27 INFO - PROCESS | 1913 | __end_tp_report 15:39:27 INFO - PROCESS | 1913 | __start_cc_report 15:39:27 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,894 15:39:27 INFO - PROCESS | 1913 | __end_cc_report 15:39:27 INFO - PROCESS | 1913 | __startTimestamp1483659567725__endTimestamp 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | ------- Summary: start ------- 15:39:27 INFO - PROCESS | 1913 | Number of tests: 14 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:130.80 Median:123.50 stddev:24.84 (20.1%) stddev-sans-first:24.67 15:39:27 INFO - PROCESS | 1913 | Values: 106.0 117.0 119.0 128.0 179.0 119.0 132.0 173.0 118.0 117.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:138.50 stddev:22.15 (16.0%) stddev-sans-first:23.24 15:39:27 INFO - PROCESS | 1913 | Values: 136.0 113.0 109.0 171.0 141.0 138.0 112.0 114.0 139.0 95.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:208.90 Median:199.50 stddev:28.61 (14.3%) stddev-sans-first:30.07 15:39:27 INFO - PROCESS | 1913 | Values: 198.0 202.0 228.0 285.0 200.0 195.0 195.0 195.0 192.0 199.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:70.30 Median:77.00 stddev:10.88 (14.1%) stddev-sans-first:9.72 15:39:27 INFO - PROCESS | 1913 | Values: 87.0 78.0 77.0 82.0 59.0 61.0 60.0 63.0 77.0 59.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:80.00 stddev:8.44 (10.5%) stddev-sans-first:8.31 15:39:27 INFO - PROCESS | 1913 | Values: 86.0 71.0 88.0 74.0 69.0 70.0 86.0 69.0 71.0 87.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:89.50 stddev:5.74 (6.4%) stddev-sans-first:6.06 15:39:27 INFO - PROCESS | 1913 | Values: 90.0 89.0 107.0 89.0 92.0 87.0 92.0 89.0 90.0 88.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:114.80 Median:168.00 stddev:28.41 (16.9%) stddev-sans-first:23.91 15:39:27 INFO - PROCESS | 1913 | Values: 164.0 100.0 100.0 99.0 113.0 99.0 172.0 99.0 101.0 101.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:91.00 stddev:3.74 (4.1%) stddev-sans-first:3.90 15:39:27 INFO - PROCESS | 1913 | Values: 90.0 93.0 90.0 90.0 102.0 91.0 93.0 91.0 89.0 91.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.50 stddev:5.51 (9.4%) stddev-sans-first:5.73 15:39:27 INFO - PROCESS | 1913 | Values: 56.0 55.0 55.0 54.0 59.0 60.0 58.0 58.0 65.0 72.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:73.00 stddev:5.07 (6.9%) stddev-sans-first:4.90 15:39:27 INFO - PROCESS | 1913 | Values: 66.0 68.0 73.0 83.0 76.0 74.0 68.0 68.0 70.0 73.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:83.50 stddev:7.32 (8.8%) stddev-sans-first:7.72 15:39:27 INFO - PROCESS | 1913 | Values: 84.0 85.0 82.0 83.0 83.0 79.0 92.0 104.0 81.0 89.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:148.00 stddev:10.90 (7.4%) stddev-sans-first:10.82 15:39:27 INFO - PROCESS | 1913 | Values: 136.0 142.0 146.0 138.0 136.0 160.0 157.0 138.0 166.0 150.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:168.00 stddev:22.18 (13.2%) stddev-sans-first:23.19 15:39:27 INFO - PROCESS | 1913 | Values: 165.0 166.0 161.0 160.0 166.0 170.0 170.0 164.0 212.0 222.0 15:39:27 INFO - PROCESS | 1913 | 15:39:27 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:78.50 stddev:9.26 (11.8%) stddev-sans-first:9.51 15:39:27 INFO - PROCESS | 1913 | Values: 70.0 72.0 89.0 82.0 68.0 66.0 68.0 75.0 87.0 89.0 15:39:27 INFO - PROCESS | 1913 | -------- Summary: end -------- 15:39:27 INFO - PROCESS | 1913 | 15:39:28 INFO - TEST-INFO | 1913: exit 0 15:39:28 INFO - TEST-OK | kraken | took 59022ms 15:39:28 INFO - SUITE-END | took 1171s 15:39:28 INFO - Completed test suite (00:19:31) 15:39:28 INFO - javascript benchmark 15:39:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7478.000985983182, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3442.9483557746635, 3557.8398972046257, 3563.465480177974, 3590.8743193988216, 3592.0840185752663, 5858.76564937402, 5933.199018132551, 5944.019236825919, 5947.88104237915, 5960.582759206857, 5922.111683247515, 5929.0, 5954.732037058332, 5997.160397544337, 6013.579049466539, 5348.91976620351, 5368.758405871726, 5404.756785944642, 5433.347998240217, 5485.533729632986, 5425.755840987145, 5429.9185512217155, 5437.238786569884, 5440.265564148848, 5464.836054918339, 5332.013577488177, 5337.5196232339085, 5442.102053161224, 5455.727213639322, 5491.505764481196, 5353.7590808413715, 5365.114756065244, 5383.111786555213, 5385.865353366158, 5421.484958928895, 5322.281491998569, 5336.17289320156, 5368.355797304349, 5409.594280428983, 5442.8911421771345, 5850.297964244275, 5925.4370834770625, 6018.15745795589, 6071.817845464643, 6095.817125486243, 6157.2919114301985, 6260.71826767792, 6297.968510157466, 6305.117283580303, 6326.5255105867245, 6352.364763523657, 6368.0, 6377.681115944184, 6379.393957574023, 6390.105385246069, 5877.147813567094, 5917.704114794243, 6000.489958353502, 6066.696665166724, 6082.1789058477425, 6423.454006409507, 6501.609903405811, 6530.05314229434, 6530.085787989685, 6538.869222615521, 6284.685765711788, 6296.212973378328, 6302.905456418157, 6312.810615681537, 6315.115883776275, 6164.6917654117115, 6290.433860952537, 6372.745090196433, 6376.107344971708, 6380.361963803675, 6181.011038233861, 6200.596961197508, 6236.469900058455, 6286.277078136073, 6297.968510157511, 6252.843678908063, 6262.53031022666, 6269.65516896566, 6271.905921411182, 6287.622742635456, 4066.837326506966, 4311.913761724748, 4979.875503112451, 5073.289739436482, 5073.720945347967, 4501.414816073955, 4507.3689683444345, 4512.984578469818, 4573.611243044312, 4577.176108300538, 5492.176173573916, 5569.0, 5582.86042848932, 5752.453516915886, 6122.020476723703, 6213.1922850029205, 6268.09112678659, 6325.557210995278, 6362.395572420613, 6379.266384365857, 6009.549283803644, 6054.8183554493435, 6112.655464441461, 6114.11345354921, 6116.792316687763, 5568.276124103922, 5570.387257401682, 5589.636673616202, 5591.217229587861, 5604.4395560444445, 5364.980653675789, 6491.961286194186, 6574.76988305407, 6607.504437167232, 6626.900596491057, 4523.434570678665, 6236.34518375564, 6253.7185826637, 6295.087212354275, 6340.682965851781, 6523.804285871432, 6562.967185164043, 6570.77002304917, 6578.671066446563, 6589.439897608565, 6266.6992953209, 6280.560360774702, 6289.779857704958, 6318.0, 6322.589031712924, 6218.409251121137, 6259.374062593704, 6263.997760358321, 6274.341194174728, 6328.335524770017, 4902.901941961212, 5512.724363781875, 6271.278802937721, 6282.780102696383, 6283.748650053946, 6184.474319682878, 6255.24937007562, 6270.4670103039925, 6287.96856015717, 6313.684315784284, 4528.43394575678, 4542.477615074309, 5783.306003279633, 6008.54935879802, 6132.98805697055, 6223.906641400473, 6236.189295391751, 6236.688165591793, 6258.405451482102, 6268.091126786681, 6017.608855424383, 6146.631202127886, 6168.228971378578, 6168.691565421801, 6175.722092505938], "value": 5805.967954091282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.48372532077366, 487.536840001998, 537.1727539589033, 556.2296219735666, 573.9598228124033, 34223.0, 43092.56907430925, 43094.569054309446, 43147.56852431479, 43155.78422107893, 43751.56248437522, 44130.0, 44145.0, 44191.99999999992, 44247.77876110615, 9967.95016024919, 9968.0, 10006.19950403966, 10156.644517441891, 10157.339772914775, 7588.051493563305, 7917.0, 8712.912870871305, 9935.0, 10062.748431289203, 9933.801323973516, 10024.899751002506, 10045.547950342252, 10049.547770350351, 10067.29528932975, 9947.602095916154, 10012.04885535873, 10016.64941727036, 10065.59737610502, 10080.697579072566, 9819.852702209473, 9867.654632087915, 9875.90124098757, 9957.701268961942, 9991.950040249752, 41698.37452438216, 42211.788941055405, 42485.78757106195, 42577.78711106456, 42706.14587708259, 3155.7159855613104, 3306.570145881044, 3368.6046050806494, 3450.9654903450896, 4219.156168766228, 32232.355352893046, 32357.6764232357, 32415.6758432415, 32852.507212391836, 32862.0, 2796.258991367289, 3183.1405520509566, 3268.96731032689, 3290.045886692856, 3382.019214427813, 502550.0, 504161.0, 504381.0, 506005.0, 506199.0, 66520.66739666367, 67060.0, 67406.66296668485, 67483.0, 67575.0, 35859.28281434357, 36049.27901441957, 36070.0, 37954.810225949244, 70060.64969675119, 17973.820261797475, 18009.2796288147, 18114.909425452788, 18165.455036348932, 18176.727349089775, 13697.452101915811, 13711.794323085162, 13823.447062117604, 13826.654333641538, 13839.584812455643, 19877.60244795125, 19932.402027939184, 20232.89883550602, 20420.89789551043, 20460.181592736124, 6963.338482844122, 8254.739377945678, 8328.375371847136, 8368.163183681705, 8384.329253659693, 837.7989282572139, 850.2602735620051, 881.405051590174, 971.9757006074764, 988.0070529118191, 30091.0, 31948.680513195035, 32156.517652235234, 32224.677753222637, 32377.35245295081, 941.0003742048148, 1084.1760262200785, 1127.9492422840829, 1139.584051821096, 1155.6648571914218, 12473.688157796129, 16530.338786448647, 16631.334746610242, 16705.6658866822, 16846.57883552921, 651347.0, 665435.0, 686836.0, 695170.0, 696768.0, 54030.45969540254, 55295.17057244144, 55370.723146384815, 55578.16632750512, 55864.88270234654, 1376.5388594820647, 1420.6235347632885, 1425.4583258361963, 1430.4206796247329, 1436.2387934394997, 30146.857020243875, 31832.840835795672, 32038.519422209152, 32059.800664451937, 32196.0, 53169.46830531645, 53713.0, 53759.462405375445, 53818.46181538134, 54008.72995635154, 593622.0, 595226.0, 595308.0, 597249.0, 597346.0, 28033.719662803112, 28194.577081343385, 28260.010899618414, 28466.57300140541, 28508.0, 49330.26004609862, 50418.49581504138, 51034.74482627563, 51458.0, 51826.0, 33098.66901330956, 34443.827780860935, 40899.7955010223, 41804.0, 42810.57189428191, 33598.0, 38430.80784596059, 40544.391834121925, 40602.39096413615, 42180.78909605432, 35123.648763512036, 39273.80363098166, 40122.59877401189, 40382.1923561533, 40418.59581404148, 33521.83239083789, 35538.0, 35887.46168807522, 36354.0, 36679.449808252364, 24418.0, 25241.0, 26549.336266592716, 26554.867225663747, 27252.863735681196], "value": 20484.86992478647, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9402798538241, 375.5549673636739, 382.88704832074535, 383.8157684311529, 402.0772327508368, 19030.429087127373, 19487.902560487215, 20864.0, 21744.0, 21929.342119736393, 20628.17487300506, 21050.789492105076, 21169.94150292487, 21239.787602123975, 21633.242836500685, 5862.589618726691, 5870.970645146779, 6056.0, 6150.538709596775, 6156.2920264169525, 4363.323684828841, 4591.931121033187, 5450.645708028966, 6008.789692360769, 6109.969450152766, 6671.966640166793, 6684.4986626003, 6782.423494003016, 6796.320367963189, 6808.761693340734, 6502.9349706503035, 6680.565763225375, 6691.895837186858, 6778.728850845961, 6855.383015528626, 5758.62568933018, 5853.443922827325, 5909.8227053188475, 5962.433568810956, 5995.340512543617, 26787.46425071507, 26794.732052679417, 26813.731862681514, 26822.865885670642, 27102.728972710218, 2494.8004159667366, 2529.8988040478357, 3103.90688279352, 3173.587433633636, 3223.8226897520626, 15304.923475382664, 15762.369505219778, 15824.920875395665, 16357.263923123488, 16545.91727041369, 1834.4221570205343, 1859.5537071102974, 1940.8544359173118, 1941.4466876940005, 2021.6361055010093, 121467.0, 123046.38476807649, 127446.36276818557, 127738.0, 128775.0, 11110.0, 11133.387663678575, 11611.0, 11656.475458604384, 11820.468078936468, 14207.573772786833, 14473.78289325661, 14492.565223043115, 14520.709585808225, 14556.199409032604, 8931.687390941286, 9143.13140251675, 9149.313801464918, 9161.167766446737, 9256.537173141316, 7725.768226953201, 9311.953440232755, 9329.253659707207, 9417.058294170529, 9548.331616786758, 6894.862102757917, 6946.2011868634745, 6951.7219311228, 6982.965085174542, 7053.541519801196, 1593.3706186056675, 1642.5729310379388, 1682.6971145193982, 1836.2287839107607, 1889.6126294109674, 748.5059860492158, 859.6260626627437, 916.867054277126, 1020.1328870460198, 1046.6702988558732, 21408.357749267547, 21564.46088847791, 21571.460713481974, 21688.674669879965, 21861.67207491889, 794.6463823598559, 841.195635362157, 860.3461369359331, 861.1388611388611, 936.6440752514001, 9555.713328600154, 11411.42942852854, 11453.54185832574, 11480.827787583194, 11548.191626586058, 510298.0, 526097.0, 526248.0, 618714.0, 633345.0, 101632.0, 111255.88744112618, 121999.78000220061, 122765.0, 124284.0, 981.4160574458186, 983.0, 999.6751055906714, 1001.2540657210279, 1004.3572113847143, 18572.628547428707, 19016.904915475887, 19205.615887681888, 19226.711599325743, 19280.903595481934, 44309.67070987875, 51973.96052078862, 52449.737751311, 53112.73443632757, 54718.0, 60295.0, 75210.24789752033, 77546.22453775391, 78069.43861122859, 83625.0, 7943.0, 7983.042034955843, 8023.638936247766, 8062.234087761653, 8104.108548059827, 10820.837687434852, 12463.875361246271, 12477.688057798629, 12602.054845886412, 12708.618741437771, 10823.404712740874, 10846.728831779268, 10929.18031147683, 10991.0, 11281.21031527785, 8689.826203476021, 10525.36847789135, 10838.566457341618, 10859.945700271448, 10946.507407166537, 10948.397838118979, 11055.170862185207, 11256.437178141225, 11493.48279327449, 11544.365059921785, 6953.548019378724, 7011.6494175292055, 7379.114506259283, 7417.8145546361775, 8002.319802816825, 9026.81946361056, 10784.730381740519, 10891.296540165362, 11084.862076026739, 11129.0], "value": 9869.570787546943, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.9428422863082, 1535.1863512338462, 1742.5817803727102, 1887.4998125496754, 1900.4868685454928, 8267.049289331728, 8501.362397820158, 8861.689840855572, 9525.476098814572, 9581.616735330586, 8103.311218546416, 8790.120987901206, 8910.465372077664, 9283.53582320883, 9307.813843723121, 2405.326508577601, 2430.440998570321, 2430.7812296893276, 2431.501542183848, 2435.671184390111, 2399.0883464283547, 2406.097713357491, 2407.879606019701, 2410.80713542917, 2441.5361081394567, 2317.339558225906, 2396.2212281008656, 2432.525657496789, 2438.0491608272787, 2443.3158715559584, 2083.447886310129, 2342.461233916209, 2355.9293221203393, 2393.4375421775867, 2398.9880050599722, 2017.5763089751024, 2034.298167132337, 2170.6526955687013, 2214.7154650302946, 2410.0239403041796, 9295.0, 9330.626774928995, 9347.97172311052, 9430.481323527203, 9460.0, 5477.1510415885605, 5514.6139770216105, 5602.327720673505, 5634.408387119375, 5638.323401191842, 2920.211542883431, 3444.7416443766565, 3540.4866294387425, 3614.945775813365, 3676.246369494247, 1058.3385384134915, 1068.9625863094755, 1083.6694808083532, 1093.3002878157986, 1103.3545375955075, 10511.737206569896, 10764.138868890548, 12376.381180940916, 12392.0, 12401.25592464455, 4810.6632535722865, 4877.878053048702, 4887.828925987574, 4959.330490383824, 4990.950090499121, 8542.0, 10061.69814905554, 10169.084782369622, 10342.948285258526, 10352.844707329396, 4830.637702172351, 5427.267318911975, 5469.0, 5470.0, 5489.9569081875115, 4623.329617205553, 4729.881752956204, 5031.949680503221, 5034.34553508049, 5116.718580478035, 4123.422720819088, 4165.852514752442, 4227.534971153171, 4241.448611680524, 4273.7008409411665, 1325.7679906016601, 1326.2241588670736, 1337.2511393619604, 1344.6436694276024, 1350.2506109109538, 933.3046880074253, 938.4510061614033, 944.263474489899, 946.1579194516886, 967.3180407812475, 5802.33273173582, 5854.414558544197, 5897.3807750185615, 5974.462298393166, 6142.477889379364, 415.60309904041566, 447.3558076370017, 448.3789950918002, 461.3011287898836, 461.55459981118383, 3957.7229593928723, 3995.6603688686205, 4017.979910100489, 4020.8592699255387, 4122.793860306972, 9452.291078169164, 10584.788304233873, 10930.945345273381, 10977.012068913837, 11123.888761112446, 10597.788044239072, 10845.51195196218, 11032.669019929415, 11038.227324087398, 11078.113750899909, 8393.832123357499, 8417.579121043924, 8524.744257672155, 8592.699255526026, 8610.483370997761, 5813.186153938536, 5901.350851406256, 5923.437273459014, 5931.495822854933, 6014.097885317237, 10192.13366863825, 10214.846777298495, 10217.182625389802, 10395.94802025985, 10458.895411045793, 10108.595656173671, 10485.16118710486, 10508.474576271003, 10604.522796474022, 10700.464976751287, 7078.327558881898, 7281.599512026889, 7732.729354472566, 7920.089189743023, 8078.959605201936, 8629.352798540009, 8631.093735157718, 8788.648454062022, 8855.955720221358, 8876.846010018657, 7602.315791578563, 7717.112532058885, 7759.7672069838, 7773.805654858674, 7852.057753069668, 7549.50928189666, 7672.38620910337, 7698.384129269757, 7704.345130663956, 7724.995750552393, 7062.788116356517, 7142.321479459443, 7183.784486465414, 7208.531445456028, 7213.567185968649, 4945.925811112764, 4951.480094590016, 4974.801007959641, 5114.744262786771, 5120.667156634807, 5157.020166168416, 5170.689758614495, 5180.663256888291, 5180.844574662766, 5207.375114986075], "value": 4601.057705234081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.1628734812717, 296.72404663662786, 298.51044287368717, 301.18078825594375, 306.9232691827043, 4969.931464735081, 5134.974325128378, 5165.225216217569, 5525.944740552598, 5602.0, 4324.783760811954, 5534.529564986981, 5547.639403438774, 5565.471280228382, 5576.525995290405, 3974.304496713078, 4024.839006439739, 4259.765712885783, 4309.806058727365, 4335.6965012449145, 3350.1959529712817, 3817.503724515809, 4302.075053863418, 4304.461942257218, 4318.373835793808, 3293.127321259868, 3547.0, 4057.9043658212263, 4124.876253712393, 4140.648044916185, 3423.657634236569, 3758.1544152565452, 4095.85664501744, 4128.669706423494, 4191.434156388879, 3005.3388254583956, 3059.969400306013, 3137.545055966895, 3424.3188572284644, 3579.355715971124, 4682.438107427097, 4757.666963312569, 5336.573074154058, 5388.245645609618, 5425.9728701356635, 3881.437191607201, 4230.386593943892, 4426.9817941873225, 4660.673752837302, 4737.057806299401, 5442.911417716433, 5542.501174894239, 5872.735726892257, 5884.264466941632, 5908.556858235649, 3256.348730253959, 3652.7077833773233, 3755.8356909358185, 3883.4951456310782, 3917.373220284769, 6202.3797620238065, 6244.500439964792, 6253.0, 6266.4360207581085, 6290.150829637986, 3363.5627368442433, 3996.580359062257, 4017.678585713136, 4026.0337518995816, 4039.899002524902, 3961.3265744823448, 4032.475778148822, 4050.8177132029127, 4060.573639767841, 4108.239975604522, 4682.859514214579, 4707.905841883143, 4743.762811859393, 4750.548697873696, 4772.642051846056, 5143.794248230104, 5884.293884733774, 5924.911126333109, 5955.791547295824, 6034.577579569388, 1283.5315109984788, 1341.222091187109, 1346.8451128120391, 1370.8560601136937, 1379.2620947792882, 736.3262614707589, 899.536738579632, 922.5894476957824, 923.6674797073048, 924.2282693950626, 5597.888042239132, 5616.241807356037, 5632.943975449013, 5633.577481688808, 5638.577106716931, 4868.683535570177, 5216.904450065453, 5284.497972692588, 5636.802711905064, 6059.333473317932, 4612.861614151514, 5050.696958182447, 5244.370675518886, 5610.719464026783, 5658.596040781044, 3150.897185984887, 3176.8411579420936, 3190.330030693534, 3240.0, 3245.302260014061, 5840.766369345263, 5842.532597392198, 5899.76400943966, 6275.924796849511, 6304.527160462983, 5659.009673307155, 5987.520998320211, 6192.368243496496, 6227.688615569294, 6227.723316720061, 6334.936650633527, 6361.5546911716665, 6367.586106903036, 6377.2028496437015, 6400.903421810139, 5816.73824677882, 5852.092925596539, 6019.759209631566, 6032.526664067711, 6157.6613286269685, 5679.574031947538, 5976.581639285208, 5980.611260268069, 6029.78895738647, 6063.939360606338, 5490.684467470455, 6129.0999790065225, 6148.401415631878, 6339.809805705836, 6420.1974753155855, 3755.2489502099143, 3918.3730603103368, 3927.6072392760493, 3976.0, 3984.521857377133, 4306.956930430656, 6066.514678825772, 6100.75596976116, 6111.1444397785235, 6113.724882380393, 5410.540104091197, 5647.463490968352, 5852.297724272944, 5903.852403689943, 5958.910616340845, 4423.159599676052, 4742.905141897212, 5388.551327150705, 5756.5822354612, 5977.9402205977385, 4943.332650092191, 5473.644213126134, 5584.291618565074, 5764.279465066867, 5779.734450035717, 4824.815621689668, 5706.600537962303, 5834.899436203048, 5885.793997210249, 5935.011771056745, 5293.497117773805, 5749.568782341425, 5798.33319168301, 5818.214541037075, 5865.530757539302], "value": 4219.39754388013, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.2174197511749, 757.2881491398089, 821.5645707774879, 823.8434697407496, 850.7320194138848, 13559.661008474768, 14409.71180576389, 14462.276886155703, 15248.466303679374, 15265.694686106284, 14600.269986500685, 14853.702925941501, 14926.626834329147, 14937.626559336022, 14993.550193494186, 680.6834821807859, 700.8668353012937, 841.364769598955, 841.8779277004846, 858.7295002074327, 835.1189495082685, 842.8103676672761, 844.8563744163476, 845.0366582096384, 846.5301757524571, 712.6650474277081, 788.6293442082213, 851.8764779107025, 863.8661007543841, 871.4292138649195, 758.6093162021564, 883.1918794303205, 888.4891187567142, 889.666375109334, 890.7773056735816, 569.829051284613, 621.0994058614981, 625.7859752080948, 667.4993754683987, 670.2325836916751, 13349.998750093684, 13664.863351366459, 14616.415343386252, 14724.0, 14892.62768430798, 14928.0, 15177.317020734094, 15187.924060379628, 15238.771418428732, 15319.617009574738, 11660.0, 11805.58680446189, 11809.468573914195, 12060.879391206152, 12414.317212553306, 3892.3577609694366, 3972.781497017663, 3981.442598036277, 4029.254587901218, 4075.1849630074103, 122626.54746905011, 127353.72646273511, 128620.0, 129186.0, 130757.0, 11498.885011149781, 11769.0, 11804.232724872856, 11928.642140735792, 11986.92117709393, 24249.151279705125, 24303.63544546833, 24350.756492435205, 24545.0, 24623.261302160965, 8228.876566851503, 8296.170382961656, 8334.20825021622, 8358.164183581594, 8420.4947703138, 4301.268784306675, 4377.737335759864, 4411.779411029435, 4587.632989360844, 4715.7642117893965, 3702.241040586673, 3748.1379282765115, 3793.1275806564645, 3818.6181381861593, 3847.7691338519217, 663.6980174020905, 671.1007250284642, 672.7443571442918, 675.5575098310615, 691.0981169573654, 617.3240301869446, 638.7618153551128, 642.3929386729495, 688.721067967474, 692.3714965455944, 8176.83646327082, 8853.247473964786, 8975.730728078168, 9404.95297523508, 9483.688056542735, 542.7232111623022, 613.5459759777732, 675.6722989350161, 685.8868286732633, 686.5160062156168, 4149.170165966819, 4626.768661566908, 4660.627149828006, 4702.482726900038, 4721.0, 140401.0, 148498.0, 156113.0, 156246.0, 156753.0, 86243.0, 95712.0428795717, 105909.47045264725, 114549.0, 140771.29614351862, 110421.0, 114660.0, 115424.42287788675, 116071.41964290125, 119062.8093719069, 8617.526036068077, 8665.393422460367, 8897.866532002156, 9129.132732390412, 9375.156235938799, 47594.0, 57866.71066644808, 60457.093143602004, 60999.69500152648, 62287.37712622997, 67031.0, 79194.0, 94743.0, 100031.0, 103995.0, 9178.495182764746, 11246.12008856943, 11848.644540663794, 11859.110566707359, 11898.107641926717, 12488.0, 13007.024473164362, 13026.153300035467, 13093.41079651437, 13244.801327979896, 12008.459619316976, 12055.879441205476, 12249.755004900031, 12348.073894458132, 12615.621531354074, 11894.762104758029, 12182.451789669309, 12214.816777748163, 12238.632841014783, 12691.111622186727, 10326.638567650096, 10388.0, 11549.538018479503, 12050.211709083376, 12183.512659493876, 9901.653442129491, 9923.503824808875, 9994.650187243411, 10124.797504050026, 10180.440075795606, 10343.793124137626, 10563.94718026405, 10565.683029509128, 10579.994900484442, 10598.099161571045], "value": 7672.791827800613, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 119.0, 128.0, 179.0, 119.0, 132.0, 173.0, 118.0, 117.0], "value": 130.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 113.0, 109.0, 171.0, 141.0, 138.0, 112.0, 114.0, 139.0, 95.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 202.0, 228.0, 285.0, 200.0, 195.0, 195.0, 195.0, 192.0, 199.0], "value": 208.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 77.0, 82.0, 59.0, 61.0, 60.0, 63.0, 77.0, 59.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 88.0, 74.0, 69.0, 70.0, 86.0, 69.0, 71.0, 87.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 107.0, 89.0, 92.0, 87.0, 92.0, 89.0, 90.0, 88.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 100.0, 100.0, 99.0, 113.0, 99.0, 172.0, 99.0, 101.0, 101.0], "value": 114.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 90.0, 90.0, 102.0, 91.0, 93.0, 91.0, 89.0, 91.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 59.0, 60.0, 58.0, 58.0, 65.0, 72.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 73.0, 83.0, 76.0, 74.0, 68.0, 68.0, 70.0, 73.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 83.0, 83.0, 79.0, 92.0, 104.0, 81.0, 89.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 146.0, 138.0, 136.0, 160.0, 157.0, 138.0, 166.0, 150.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 161.0, 160.0, 166.0, 170.0, 170.0, 164.0, 212.0, 222.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 89.0, 82.0, 68.0, 66.0, 68.0, 75.0, 87.0, 89.0], "value": 76.6, "unit": "score"}]}]} 15:39:28 INFO - Return code: 0 15:39:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:29 ERROR - # TBPL SUCCESS # 15:39:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:39:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:39:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:39:29 INFO - 2017-01-05 15:39:29.036 screenresolution[1918:16512] starting screenresolution argv=screenresolution get 15:39:29 INFO - 2017-01-05 15:39:29.038 screenresolution[1918:16512] Display 0: 1600x1200x32@60 15:39:29 INFO - 2017-01-05 15:39:29.044 screenresolution[1919:16515] starting screenresolution argv=screenresolution list 15:39:29 INFO - Available Modes on Display 0 15:39:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:39:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:39:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:39:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:39:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:39:29 INFO - Intel Iris: 15:39:29 INFO - Chipset Model: Intel Iris 15:39:29 INFO - Type: GPU 15:39:29 INFO - Bus: Built-In 15:39:29 INFO - VRAM (Dynamic, Max): 1536 MB 15:39:29 INFO - Vendor: Intel (0x8086) 15:39:29 INFO - Device ID: 0x0a2e 15:39:29 INFO - Revision ID: 0x0009 15:39:29 INFO - Displays: 15:39:29 INFO - Display: 15:39:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:39:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:39:29 INFO - Display Serial Number: 1600x1200 60 15:39:29 INFO - Main Display: Yes 15:39:29 INFO - Mirror: Off 15:39:29 INFO - Online: Yes 15:39:29 INFO - Rotation: Supported 15:39:29 INFO - Return code: 0 15:39:29 INFO - Running post-action listener: _resource_record_post_action 15:39:29 INFO - [mozharness: 2017-01-05 23:39:29.280751Z] Finished run-tests step (success) 15:39:29 INFO - Running post-run listener: _resource_record_post_run 15:39:29 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 2138112; Write bytes: 498474496; Read time: 23; Write time: 1737 15:39:29 INFO - TinderboxPrint: CPU usage
54.2% 15:39:29 INFO - TinderboxPrint: I/O read bytes / time
2,138,112 / 23 15:39:29 INFO - TinderboxPrint: I/O write bytes / time
498,474,496 / 1,737 15:39:29 INFO - TinderboxPrint: CPU idle
2,189.9 (45.8%) 15:39:29 INFO - TinderboxPrint: CPU system
970.3 (20.3%) 15:39:29 INFO - TinderboxPrint: CPU user
1,617.5 (33.9%) 15:39:29 INFO - TinderboxPrint: Swap in / out
198,144,000 / 0 15:39:29 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188316160; Write bytes: 188225536; Read time: 17604; Write time: 414 15:39:29 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 2138112; Write bytes: 300127744; Read time: 23; Write time: 1285 15:39:29 INFO - Running post-run listener: _upload_blobber_files 15:39:29 INFO - Blob upload gear active. 15:39:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:29 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 15:39:29 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:39:29 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:39:30 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:30 INFO - (blobuploader) - INFO - Done attempting. 15:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:39:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:31 INFO - (blobuploader) - INFO - Done attempting. 15:39:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:34 INFO - (blobuploader) - INFO - Done attempting. 15:39:34 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:34 INFO - Return code: 0 15:39:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5aad30591c6335dbfe1d069bca2124d7948f6f942d49bd54e61070413abfcd69cab15eea2354f18c028426bd2528a72b8de3056694f474292cc5d1e389e448d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00a4dc5802967c235f6062d7823ab34946912eda34e41e8f60c3da9571064ca0ec70c910b16e38b16d63f489c35d5b0c51d0e60bf8cec3e2c69df28ea8990354", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08220d27bd899dfd590c5843f8bddb28aafbd3b6a815c072329f3beb457f4d614ca680224158318467e68bd4d4018a34a4c147b528dd3ff742b906f314930737"} 15:39:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:34 INFO - Contents: 15:39:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5aad30591c6335dbfe1d069bca2124d7948f6f942d49bd54e61070413abfcd69cab15eea2354f18c028426bd2528a72b8de3056694f474292cc5d1e389e448d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00a4dc5802967c235f6062d7823ab34946912eda34e41e8f60c3da9571064ca0ec70c910b16e38b16d63f489c35d5b0c51d0e60bf8cec3e2c69df28ea8990354", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08220d27bd899dfd590c5843f8bddb28aafbd3b6a815c072329f3beb457f4d614ca680224158318467e68bd4d4018a34a4c147b528dd3ff742b906f314930737"} 15:39:34 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:34 INFO - Copying logs to upload dir... 15:39:34 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.442921 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-05 15:39:34.573611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 15:39:34.576968) ========= 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.5GuejLZhHF/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.BQHxTg1B3b/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-Beta/sha512/f5aad30591c6335dbfe1d069bca2124d7948f6f942d49bd54e61070413abfcd69cab15eea2354f18c028426bd2528a72b8de3056694f474292cc5d1e389e448d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00a4dc5802967c235f6062d7823ab34946912eda34e41e8f60c3da9571064ca0ec70c910b16e38b16d63f489c35d5b0c51d0e60bf8cec3e2c69df28ea8990354", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08220d27bd899dfd590c5843f8bddb28aafbd3b6a815c072329f3beb457f4d614ca680224158318467e68bd4d4018a34a4c147b528dd3ff742b906f314930737"} build_url:https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/cHxozjpuSRWXkSEMnv92lg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5aad30591c6335dbfe1d069bca2124d7948f6f942d49bd54e61070413abfcd69cab15eea2354f18c028426bd2528a72b8de3056694f474292cc5d1e389e448d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00a4dc5802967c235f6062d7823ab34946912eda34e41e8f60c3da9571064ca0ec70c910b16e38b16d63f489c35d5b0c51d0e60bf8cec3e2c69df28ea8990354", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08220d27bd899dfd590c5843f8bddb28aafbd3b6a815c072329f3beb457f4d614ca680224158318467e68bd4d4018a34a4c147b528dd3ff742b906f314930737"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 15:39:34.612054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 15:39:34.612470) ========= 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.5GuejLZhHF/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.BQHxTg1B3b/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005278 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 15:39:34.661661) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 15:39:34.662013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 15:39:34.662395) ========= ========= Total master_lag: 0.19 =========