builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1479014564.08 results: success (0) buildid: 20161112201920 builduid: 0c53cb301a4b4ff5b590a9ed824c4c3a revision: 950df3cfb7798d1c6b1f422457a0e398a2b74587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.077058) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.077507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.077802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.196889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.197208) ========= 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.7IbgusGkmO/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.vupUXbCjQD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-12 21:22:44-- 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% 161M=0s 2016-11-12 21:22:44 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.526634 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.750072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.750381) ========= 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.7IbgusGkmO/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.vupUXbCjQD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.024272 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:44.798117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-12 21:22:44.798472) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 950df3cfb7798d1c6b1f422457a0e398a2b74587 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 950df3cfb7798d1c6b1f422457a0e398a2b74587 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7IbgusGkmO/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.vupUXbCjQD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-12 21:22:44,886 truncating revision to first 12 chars 2016-11-12 21:22:44,886 Setting DEBUG logging. 2016-11-12 21:22:44,886 attempt 1/10 2016-11-12 21:22:44,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/950df3cfb779?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 21:22:46,018 unpacking tar archive at: mozilla-aurora-950df3cfb779/testing/mozharness/ program finished with exit code 0 elapsedTime=1.387406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-12 21:22:46.209842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:46.210197) ========= script_repo_revision: 950df3cfb7798d1c6b1f422457a0e398a2b74587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:46.210749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:46.211028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 21:22:46.233221) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-12 21:22:46.233764) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7IbgusGkmO/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.vupUXbCjQD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:22:46 INFO - MultiFileLogger online at 20161112 21:22:46 in /builds/slave/test 21:22:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:22:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:22:46 INFO - {'append_to_log': False, 21:22:46 INFO - 'base_work_dir': '/builds/slave/test', 21:22:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:22:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:22:46 INFO - 'branch': 'Mozilla-Aurora', 21:22:46 INFO - 'buildbot_json_path': 'buildprops.json', 21:22:46 INFO - 'config_files': ('talos/mac_config.py',), 21:22:46 INFO - 'default_actions': ('clobber', 21:22:46 INFO - 'read-buildbot-config', 21:22:46 INFO - 'download-and-extract', 21:22:46 INFO - 'populate-webroot', 21:22:46 INFO - 'create-virtualenv', 21:22:46 INFO - 'install', 21:22:46 INFO - 'run-tests'), 21:22:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:22:46 INFO - 'download_minidump_stackwalk': True, 21:22:46 INFO - 'download_symbols': 'ondemand', 21:22:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:22:46 INFO - 'tooltool.py': '/tools/tooltool.py', 21:22:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:22:46 INFO - '/tools/misc-python/virtualenv.py')}, 21:22:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:22:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:22:46 INFO - 'installer_path': 'installer.exe', 21:22:46 INFO - 'log_level': 'info', 21:22:46 INFO - 'log_name': 'talos', 21:22:46 INFO - 'log_to_console': True, 21:22:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:22:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:22:46 INFO - 'opt_config_files': (), 21:22:46 INFO - 'pip_index': False, 21:22:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:22:46 INFO - 'cmd': ('bash', 21:22:46 INFO - '-c', 21:22:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:22:46 INFO - 'enabled': True, 21:22:46 INFO - 'halt_on_failure': False, 21:22:46 INFO - 'name': 'check_screen_resolution'},), 21:22:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:22:46 INFO - 'cmd': ('bash', 21:22:46 INFO - '-c', 21:22:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:22:46 INFO - 'enabled': True, 21:22:46 INFO - 'halt_on_failure': False, 21:22:46 INFO - 'name': 'check_screen_resolution'},), 21:22:46 INFO - 'run_cmd_checks_enabled': True, 21:22:46 INFO - 'sps_profile': False, 21:22:46 INFO - 'sps_profile_interval': 0, 21:22:46 INFO - 'suite': 'dromaeojs', 21:22:46 INFO - 'system_bits': '32', 21:22:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:22:46 INFO - 'title': 't-yosemite-r7-0263', 21:22:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:22:46 INFO - 'use_talos_json': True, 21:22:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:22:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:22:46 INFO - 'work_dir': 'build'} 21:22:46 INFO - [mozharness: 2016-11-13 05:22:46.436185Z] Running clobber step. 21:22:46 INFO - Running pre-action listener: _resource_record_pre_action 21:22:46 INFO - Running main action method: clobber 21:22:46 INFO - rmtree: /builds/slave/test/build 21:22:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:22:48 INFO - Running post-action listener: _resource_record_post_action 21:22:48 INFO - [mozharness: 2016-11-13 05:22:48.768973Z] Finished clobber step (success) 21:22:48 INFO - [mozharness: 2016-11-13 05:22:48.769153Z] Running read-buildbot-config step. 21:22:48 INFO - Running pre-action listener: _resource_record_pre_action 21:22:48 INFO - Running main action method: read_buildbot_config 21:22:48 INFO - Using buildbot properties: 21:22:48 INFO - { 21:22:48 INFO - "project": "", 21:22:48 INFO - "product": "firefox", 21:22:48 INFO - "script_repo_revision": "production", 21:22:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:22:48 INFO - "repository": "", 21:22:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:22:48 INFO - "buildid": "20161112201920", 21:22:48 INFO - "pgo_build": "False", 21:22:48 INFO - "basedir": "/builds/slave/test", 21:22:48 INFO - "buildnumber": 28, 21:22:48 INFO - "slavename": "t-yosemite-r7-0263", 21:22:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:22:48 INFO - "platform": "yosemite_r7", 21:22:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:22:48 INFO - "branch": "mozilla-aurora", 21:22:48 INFO - "repo_path": "releases/mozilla-aurora", 21:22:48 INFO - "revision": "950df3cfb7798d1c6b1f422457a0e398a2b74587", 21:22:48 INFO - "stage_platform": "macosx64", 21:22:48 INFO - "builduid": "0c53cb301a4b4ff5b590a9ed824c4c3a", 21:22:48 INFO - "slavebuilddir": "test" 21:22:48 INFO - } 21:22:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:22:48 INFO - Running post-action listener: _resource_record_post_action 21:22:48 INFO - [mozharness: 2016-11-13 05:22:48.772518Z] Finished read-buildbot-config step (success) 21:22:48 INFO - [mozharness: 2016-11-13 05:22:48.772667Z] Running download-and-extract step. 21:22:48 INFO - Running pre-action listener: _resource_record_pre_action 21:22:48 INFO - Running main action method: download_and_extract 21:22:48 INFO - mkdir: /builds/slave/test/build/tests 21:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:48 INFO - trying https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:22:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:22:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 21:22:50 INFO - Downloaded 1199 bytes. 21:22:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:22:50 INFO - Using the following test package requirements: 21:22:50 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:22:50 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:22:50 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:22:50 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'jsshell-mac.zip'], 21:22:50 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:22:50 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:22:50 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:22:50 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:22:50 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:22:50 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:22:50 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:22:50 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:22:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:22:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:22:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:22:50 INFO - Expected file size: 16423762 21:22:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:22:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:22:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:22:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:22:58 INFO - Expected file size: 16423762 21:23:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:23:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:23:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:23:05 INFO - Expected file size: 14414089 21:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:06 INFO - trying https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:23:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 21:23:09 INFO - Downloaded 115553430 bytes. 21:23:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:23:09 INFO - mkdir: /builds/slave/test/properties 21:23:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:23:09 INFO - Writing to file /builds/slave/test/properties/build_url 21:23:09 INFO - Contents: 21:23:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:23:10 INFO - Running post-action listener: _resource_record_post_action 21:23:10 INFO - Running post-action listener: set_extra_try_arguments 21:23:10 INFO - [mozharness: 2016-11-13 05:23:10.562721Z] Finished download-and-extract step (success) 21:23:10 INFO - [mozharness: 2016-11-13 05:23:10.562867Z] Running populate-webroot step. 21:23:10 INFO - Running pre-action listener: _resource_record_pre_action 21:23:10 INFO - Running main action method: populate_webroot 21:23:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:23:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:23:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:23:10 INFO - '--tppagecycles', 21:23:10 INFO - '7'], 21:23:10 INFO - 'tests': ['tsvgm']}}, 21:23:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:23:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:23:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:23:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:23:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:23:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['damp', 'tps']}, 21:23:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'tests': ['damp', 'tps']}, 21:23:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['dromaeo_dom']}, 21:23:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:23:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['basic_compositor_video']}, 21:23:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:23:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['a11yr', 21:23:10 INFO - 'ts_paint', 21:23:10 INFO - 'tpaint', 21:23:10 INFO - 'sessionrestore', 21:23:10 INFO - 'sessionrestore_no_auto_restore', 21:23:10 INFO - 'tabpaint']}, 21:23:10 INFO - 'other-e10s': {'tests': ['a11yr', 21:23:10 INFO - 'ts_paint', 21:23:10 INFO - 'tpaint', 21:23:10 INFO - 'sessionrestore', 21:23:10 INFO - 'sessionrestore_no_auto_restore', 21:23:10 INFO - 'tabpaint']}, 21:23:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:23:10 INFO - 'ts_paint', 21:23:10 INFO - 'tpaint', 21:23:10 INFO - 'sessionrestore', 21:23:10 INFO - 'sessionrestore_no_auto_restore', 21:23:10 INFO - 'tabpaint']}, 21:23:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:23:10 INFO - 'ts_paint', 21:23:10 INFO - 'tpaint', 21:23:10 INFO - 'sessionrestore', 21:23:10 INFO - 'sessionrestore_no_auto_restore', 21:23:10 INFO - 'tabpaint']}, 21:23:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['a11yr', 21:23:10 INFO - 'ts_paint', 21:23:10 INFO - 'tpaint', 21:23:10 INFO - 'sessionrestore', 21:23:10 INFO - 'sessionrestore_no_auto_restore', 21:23:10 INFO - 'tabpaint']}, 21:23:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['a11yr', 21:23:10 INFO - 'ts_paint', 21:23:10 INFO - 'tpaint', 21:23:10 INFO - 'sessionrestore', 21:23:10 INFO - 'sessionrestore_no_auto_restore', 21:23:10 INFO - 'tabpaint']}, 21:23:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['tsvgx', 21:23:10 INFO - 'tsvgr_opacity', 21:23:10 INFO - 'tart', 21:23:10 INFO - 'tscrollx', 21:23:10 INFO - 'cart']}, 21:23:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:23:10 INFO - 'tsvgr_opacity', 21:23:10 INFO - 'tart', 21:23:10 INFO - 'tscrollx', 21:23:10 INFO - 'cart']}, 21:23:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'talos_options': ['--disable-e10s'], 21:23:10 INFO - 'tests': ['tp5o']}, 21:23:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'tests': ['tp5o']}, 21:23:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'talos_options': ['--disable-e10s', 21:23:10 INFO - '--xperf_path', 21:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:10 INFO - 'tests': ['tp5n']}, 21:23:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:23:10 INFO - 'talos_options': ['--xperf_path', 21:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:23:10 INFO - 'tests': ['tp5n']}}, 21:23:10 INFO - 'talos.zip': {'path': '', 21:23:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:23:10 INFO - Running post-action listener: _resource_record_post_action 21:23:10 INFO - [mozharness: 2016-11-13 05:23:10.581839Z] Finished populate-webroot step (success) 21:23:10 INFO - [mozharness: 2016-11-13 05:23:10.581949Z] Running create-virtualenv step. 21:23:10 INFO - Running pre-action listener: _resource_record_pre_action 21:23:10 INFO - Running main action method: create_virtualenv 21:23:10 INFO - Creating virtualenv /builds/slave/test/build/venv 21:23:10 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 21:23:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:23:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:23:10 INFO - Using real prefix '/tools/python27' 21:23:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 21:23:14 INFO - Installing pip.................done. 21:23:14 INFO - Return code: 0 21:23:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23: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', 'pip>=1.5'] in /builds/slave/test/build 21:23: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 pip>=1.5 21:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:14 INFO - 'HOME': '/Users/cltbld', 21:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:14 INFO - 'LOGNAME': 'cltbld', 21:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:14 INFO - 'MOZ_NO_REMOTE': '1', 21:23:14 INFO - 'NO_EM_RESTART': '1', 21:23:14 INFO - 'PAGER': '/bin/cat', 21:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:14 INFO - 'PWD': '/builds/slave/test', 21:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:14 INFO - 'SHELL': '/bin/bash', 21:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:14 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:14 INFO - 'USER': 'cltbld', 21:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:14 INFO - 'XPC_FLAGS': '0x0', 21:23:14 INFO - 'XPC_SERVICE_NAME': '0', 21:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:14 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 21:23:14 INFO - Cleaning up... 21:23:14 INFO - Return code: 0 21:23:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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', '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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:23: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 psutil>=3.1.1 21:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:14 INFO - 'HOME': '/Users/cltbld', 21:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:14 INFO - 'LOGNAME': 'cltbld', 21:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:14 INFO - 'MOZ_NO_REMOTE': '1', 21:23:14 INFO - 'NO_EM_RESTART': '1', 21:23:14 INFO - 'PAGER': '/bin/cat', 21:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:14 INFO - 'PWD': '/builds/slave/test', 21:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:14 INFO - 'SHELL': '/bin/bash', 21:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:14 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:14 INFO - 'USER': 'cltbld', 21:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:14 INFO - 'XPC_FLAGS': '0x0', 21:23:14 INFO - 'XPC_SERVICE_NAME': '0', 21:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:14 INFO - Downloading/unpacking psutil>=3.1.1 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:23:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:17 INFO - Installing collected packages: psutil 21:23:17 INFO - Running setup.py install for psutil 21:23:18 INFO - building 'psutil._psutil_osx' extension 21:23:18 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 21:23:18 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 21:23:18 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 21:23:18 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 21:23:18 INFO - building 'psutil._psutil_posix' extension 21:23:18 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 21:23:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:23:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:23:18 INFO - ^ 21:23:18 INFO - 1 warning generated. 21:23:18 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 21:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:23:19 INFO - Successfully installed psutil 21:23:19 INFO - Cleaning up... 21:23:19 INFO - Return code: 0 21:23:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:23:19 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')]} 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 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')]} 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:19 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:19 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 21:23:19 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 21:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:19 INFO - 'HOME': '/Users/cltbld', 21:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:19 INFO - 'LOGNAME': 'cltbld', 21:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:19 INFO - 'MOZ_NO_REMOTE': '1', 21:23:19 INFO - 'NO_EM_RESTART': '1', 21:23:19 INFO - 'PAGER': '/bin/cat', 21:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:19 INFO - 'PWD': '/builds/slave/test', 21:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:19 INFO - 'SHELL': '/bin/bash', 21:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:19 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:19 INFO - 'USER': 'cltbld', 21:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:19 INFO - 'XPC_FLAGS': '0x0', 21:23:19 INFO - 'XPC_SERVICE_NAME': '0', 21:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:23:21 INFO - Installing collected packages: mozsystemmonitor 21:23:21 INFO - Running setup.py install for mozsystemmonitor 21:23:22 INFO - Successfully installed mozsystemmonitor 21:23:22 INFO - Cleaning up... 21:23:22 INFO - Return code: 0 21:23:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:22 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:22 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 21:23:22 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 21:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:22 INFO - 'HOME': '/Users/cltbld', 21:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:22 INFO - 'LOGNAME': 'cltbld', 21:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:22 INFO - 'MOZ_NO_REMOTE': '1', 21:23:22 INFO - 'NO_EM_RESTART': '1', 21:23:22 INFO - 'PAGER': '/bin/cat', 21:23:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:22 INFO - 'PWD': '/builds/slave/test', 21:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:22 INFO - 'SHELL': '/bin/bash', 21:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:22 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:22 INFO - 'USER': 'cltbld', 21:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:22 INFO - 'XPC_FLAGS': '0x0', 21:23:22 INFO - 'XPC_SERVICE_NAME': '0', 21:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:22 INFO - Downloading/unpacking jsonschema==2.5.1 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23: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 21:23:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:23:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:25 INFO - Downloading functools32-3.2.3-2.tar.gz 21:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:23:25 INFO - warning: no files found matching '*.txt' 21:23:25 INFO - no previously-included directories found matching 'build' 21:23:25 INFO - no previously-included directories found matching 'dist' 21:23:25 INFO - no previously-included directories found matching '.git*' 21:23:25 INFO - Installing collected packages: jsonschema, functools32 21:23:25 INFO - Running setup.py install for functools32 21:23:25 INFO - warning: no files found matching '*.txt' 21:23:25 INFO - no previously-included directories found matching 'build' 21:23:25 INFO - no previously-included directories found matching 'dist' 21:23:25 INFO - no previously-included directories found matching '.git*' 21:23:25 INFO - Successfully installed jsonschema functools32 21:23:25 INFO - Cleaning up... 21:23:25 INFO - Return code: 0 21:23:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:23:25 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')]} 21:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:25 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')]} 21:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:25 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:25 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 21:23:25 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 21:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:25 INFO - 'HOME': '/Users/cltbld', 21:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:25 INFO - 'LOGNAME': 'cltbld', 21:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:25 INFO - 'MOZ_NO_REMOTE': '1', 21:23:25 INFO - 'NO_EM_RESTART': '1', 21:23:25 INFO - 'PAGER': '/bin/cat', 21:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:25 INFO - 'PWD': '/builds/slave/test', 21:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:25 INFO - 'SHELL': '/bin/bash', 21:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:25 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:25 INFO - 'USER': 'cltbld', 21:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:25 INFO - 'XPC_FLAGS': '0x0', 21:23:25 INFO - 'XPC_SERVICE_NAME': '0', 21:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:23:25 INFO - Cleaning up... 21:23:25 INFO - Return code: 0 21:23:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:23:25 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')]} 21:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:25 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')]} 21:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:25 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:25 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 21:23:25 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 21:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:25 INFO - 'HOME': '/Users/cltbld', 21:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:25 INFO - 'LOGNAME': 'cltbld', 21:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:25 INFO - 'MOZ_NO_REMOTE': '1', 21:23:25 INFO - 'NO_EM_RESTART': '1', 21:23:25 INFO - 'PAGER': '/bin/cat', 21:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:25 INFO - 'PWD': '/builds/slave/test', 21:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:25 INFO - 'SHELL': '/bin/bash', 21:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:25 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:25 INFO - 'USER': 'cltbld', 21:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:25 INFO - 'XPC_FLAGS': '0x0', 21:23:25 INFO - 'XPC_SERVICE_NAME': '0', 21:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:26 INFO - Downloading/unpacking blobuploader==1.2.4 21:23:26 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 21:23:26 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 21:23:26 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 21:23:26 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 21:23:26 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 21:23:26 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 21:23:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:23:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:23:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 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 21:23:29 INFO - Downloading docopt-0.6.1.tar.gz 21:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:23:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:23:30 INFO - Running setup.py install for blobuploader 21:23:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:23:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:23:30 INFO - Running setup.py install for requests 21:23:30 INFO - Running setup.py install for docopt 21:23:30 INFO - Successfully installed blobuploader requests docopt 21:23:30 INFO - Cleaning up... 21:23:30 INFO - Return code: 0 21:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:30 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')]} 21:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:30 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')]} 21:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:30 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:30 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 21:23:30 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 21:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:30 INFO - 'HOME': '/Users/cltbld', 21:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:30 INFO - 'LOGNAME': 'cltbld', 21:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:30 INFO - 'MOZ_NO_REMOTE': '1', 21:23:30 INFO - 'NO_EM_RESTART': '1', 21:23:30 INFO - 'PAGER': '/bin/cat', 21:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:30 INFO - 'PWD': '/builds/slave/test', 21:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:30 INFO - 'SHELL': '/bin/bash', 21:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:30 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:30 INFO - 'USER': 'cltbld', 21:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:30 INFO - 'XPC_FLAGS': '0x0', 21:23:30 INFO - 'XPC_SERVICE_NAME': '0', 21:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-zNRvFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-SzMsPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Zvjghn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-g78L8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-VVfEYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ICbuFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-c6OMJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:31 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-oYyedP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-UlZZBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mxntD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mRZxIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-PneTdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-acv5DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-o7meeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-sr63Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-OSbeTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:32 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NDVisn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:23:32 INFO - Running setup.py install for manifestparser 21:23:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:23:33 INFO - Running setup.py install for mozcrash 21:23:33 INFO - Running setup.py install for mozdebug 21:23:33 INFO - Running setup.py install for mozdevice 21:23:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:23:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:23:33 INFO - Running setup.py install for mozfile 21:23:33 INFO - Running setup.py install for mozhttpd 21:23:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:23:33 INFO - Running setup.py install for mozinfo 21:23:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:23:33 INFO - Running setup.py install for mozInstall 21:23:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Running setup.py install for mozleak 21:23:34 INFO - Running setup.py install for mozlog 21:23:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Running setup.py install for moznetwork 21:23:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Running setup.py install for mozprocess 21:23:34 INFO - Running setup.py install for mozprofile 21:23:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:23:34 INFO - Running setup.py install for mozrunner 21:23:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Running setup.py install for mozscreenshot 21:23:35 INFO - Running setup.py install for moztest 21:23:35 INFO - Running setup.py install for mozversion 21:23:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:23:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:23:35 INFO - Cleaning up... 21:23:35 INFO - Return code: 0 21:23:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:35 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:35 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 21:23:35 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 21:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:35 INFO - 'HOME': '/Users/cltbld', 21:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:35 INFO - 'LOGNAME': 'cltbld', 21:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:35 INFO - 'MOZ_NO_REMOTE': '1', 21:23:35 INFO - 'NO_EM_RESTART': '1', 21:23:35 INFO - 'PAGER': '/bin/cat', 21:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:35 INFO - 'PWD': '/builds/slave/test', 21:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:35 INFO - 'SHELL': '/bin/bash', 21:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:35 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:35 INFO - 'USER': 'cltbld', 21:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:35 INFO - 'XPC_FLAGS': '0x0', 21:23:35 INFO - 'XPC_SERVICE_NAME': '0', 21:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:23:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-azsK13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:23:35 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)) 21:23:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:23:35 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-f4Tu8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-LSmacV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-S6pJUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-um0Gwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Y72m5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-PwlnRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-abrhR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-RqWVz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-IsSQY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tkXaoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:23:36 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)) 21:23:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:23:36 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-XYlHQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:23:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-11SgJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:23:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-SEalHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pECEQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:23:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-bvAbsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:23:37 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)) 21:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:23:37 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-QHvtPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 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)) 21:23:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:23:37 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 21:23:37 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 21:23:37 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 21:23:37 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 21:23:37 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 21:23:37 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 21:23:40 INFO - Downloading blessings-1.6.tar.gz 21:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:23:40 INFO - Installing collected packages: blessings 21:23:40 INFO - Running setup.py install for blessings 21:23:40 INFO - Successfully installed blessings 21:23:40 INFO - Cleaning up... 21:23:40 INFO - Return code: 0 21:23:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:40 INFO - Reading from file tmpfile_stdout 21:23:40 INFO - Current package versions: 21:23:40 INFO - blessings == 1.6 21:23:40 INFO - blobuploader == 1.2.4 21:23:40 INFO - docopt == 0.6.1 21:23:40 INFO - functools32 == 3.2.3-2 21:23:40 INFO - jsonschema == 2.5.1 21:23:40 INFO - manifestparser == 1.1 21:23:40 INFO - mozInstall == 1.12 21:23:40 INFO - mozcrash == 0.17 21:23:40 INFO - mozdebug == 0.1 21:23:40 INFO - mozdevice == 0.48 21:23:40 INFO - mozfile == 1.2 21:23:40 INFO - mozhttpd == 0.7 21:23:40 INFO - mozinfo == 0.9 21:23:40 INFO - mozleak == 0.1 21:23:40 INFO - mozlog == 3.4 21:23:40 INFO - moznetwork == 0.27 21:23:40 INFO - mozprocess == 0.23 21:23:40 INFO - mozprofile == 0.28 21:23:40 INFO - mozrunner == 6.12 21:23:40 INFO - mozscreenshot == 0.1 21:23:40 INFO - mozsystemmonitor == 0.3 21:23:40 INFO - moztest == 0.7 21:23:40 INFO - mozversion == 1.4 21:23:40 INFO - psutil == 3.1.1 21:23:40 INFO - requests == 1.2.3 21:23:40 INFO - wsgiref == 0.1.2 21:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:23: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')]} 21:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23: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')]} 21:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:40 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 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:40 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 21:23:40 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 21:23:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:40 INFO - 'HOME': '/Users/cltbld', 21:23:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:40 INFO - 'LOGNAME': 'cltbld', 21:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:40 INFO - 'MOZ_NO_REMOTE': '1', 21:23:40 INFO - 'NO_EM_RESTART': '1', 21:23:40 INFO - 'PAGER': '/bin/cat', 21:23:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:40 INFO - 'PWD': '/builds/slave/test', 21:23:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:40 INFO - 'SHELL': '/bin/bash', 21:23:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:40 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:40 INFO - 'USER': 'cltbld', 21:23:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:40 INFO - 'XPC_FLAGS': '0x0', 21:23:40 INFO - 'XPC_SERVICE_NAME': '0', 21:23:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 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)) 21:23:41 INFO - Cleaning up... 21:23:41 INFO - Return code: 0 21:23:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:23:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bbce490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bb44570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9af2ca15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, '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.7IbgusGkmO/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.vupUXbCjQD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 21:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:23:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:23:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:41 INFO - 'HOME': '/Users/cltbld', 21:23:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:41 INFO - 'LOGNAME': 'cltbld', 21:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:41 INFO - 'MOZ_NO_REMOTE': '1', 21:23:41 INFO - 'NO_EM_RESTART': '1', 21:23:41 INFO - 'PAGER': '/bin/cat', 21:23:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:41 INFO - 'PWD': '/builds/slave/test', 21:23:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:41 INFO - 'SHELL': '/bin/bash', 21:23:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:23:41 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:23:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:41 INFO - 'USER': 'cltbld', 21:23:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:41 INFO - 'XPC_FLAGS': '0x0', 21:23:41 INFO - 'XPC_SERVICE_NAME': '0', 21:23:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:23:41 INFO - Cleaning up... 21:23:41 INFO - Return code: 0 21:23:41 INFO - Running post-action listener: _resource_record_post_action 21:23:41 INFO - Running post-action listener: _start_resource_monitoring 21:23:41 INFO - Starting resource monitoring. 21:23:41 INFO - [mozharness: 2016-11-13 05:23:41.374579Z] Finished create-virtualenv step (success) 21:23:41 INFO - [mozharness: 2016-11-13 05:23:41.375586Z] Running install step. 21:23:41 INFO - Running pre-action listener: _resource_record_pre_action 21:23:41 INFO - Running main action method: install 21:23:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:23:41 INFO - Reading from file tmpfile_stdout 21:23:41 INFO - Detecting whether we're running mozinstall >=1.0... 21:23:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:23:41 INFO - Reading from file tmpfile_stdout 21:23:41 INFO - Output received: 21:23:41 INFO - Usage: mozinstall [options] installer 21:23:41 INFO - Options: 21:23:41 INFO - -h, --help show this help message and exit 21:23:41 INFO - -d DEST, --destination=DEST 21:23:41 INFO - Directory to install application into. [default: 21:23:41 INFO - "/builds/slave/test"] 21:23:41 INFO - --app=APP Application being installed. [default: firefox] 21:23:41 INFO - mkdir: /builds/slave/test/build/application 21:23:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:24:13 INFO - Reading from file tmpfile_stdout 21:24:13 INFO - Output received: 21:24:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:24:13 INFO - Running post-action listener: _resource_record_post_action 21:24:13 INFO - [mozharness: 2016-11-13 05:24:13.936569Z] Finished install step (success) 21:24:13 INFO - [mozharness: 2016-11-13 05:24:13.936755Z] Running run-tests step. 21:24:13 INFO - Running pre-action listener: _resource_record_pre_action 21:24:13 INFO - Running main action method: run_tests 21:24:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:24:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:24:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:24:13 INFO - 2016-11-12 21:24:13.951 screenresolution[1656:13493] starting screenresolution argv=screenresolution get 21:24:13 INFO - 2016-11-12 21:24:13.953 screenresolution[1656:13493] Display 0: 1600x1200x32@60 21:24:13 INFO - 2016-11-12 21:24:13.959 screenresolution[1657:13495] starting screenresolution argv=screenresolution list 21:24:13 INFO - Available Modes on Display 0 21:24:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:24:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:24:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:24:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:24:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:24:14 INFO - Intel Iris: 21:24:14 INFO - Chipset Model: Intel Iris 21:24:14 INFO - Type: GPU 21:24:14 INFO - Bus: Built-In 21:24:14 INFO - VRAM (Dynamic, Max): 1536 MB 21:24:14 INFO - Vendor: Intel (0x8086) 21:24:14 INFO - Device ID: 0x0a2e 21:24:14 INFO - Revision ID: 0x0009 21:24:14 INFO - Displays: 21:24:14 INFO - Display: 21:24:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:24:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:24:14 INFO - Display Serial Number: 1600x1200 60 21:24:14 INFO - Main Display: Yes 21:24:14 INFO - Mirror: Off 21:24:14 INFO - Online: Yes 21:24:14 INFO - Rotation: Supported 21:24:14 INFO - Return code: 0 21:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:24:14 INFO - Python 2.7.3 21:24:14 INFO - Return code: 0 21:24:14 INFO - grabbing minidump binary from tooltool 21:24: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')]} 21:24:14 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 0x10b9e2d30>, '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 0x10b848db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b9dab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:24:14 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 21:24:14 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 21:24:14 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 21:24:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:24:14 INFO - Return code: 0 21:24:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:24:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:24:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:24:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:24:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7IbgusGkmO/Render', 21:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:24:14 INFO - 'HOME': '/Users/cltbld', 21:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:24:14 INFO - 'LOGNAME': 'cltbld', 21:24:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:24:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:24:14 INFO - 'MOZ_NO_REMOTE': '1', 21:24:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:24:14 INFO - 'NO_EM_RESTART': '1', 21:24:14 INFO - 'PAGER': '/bin/cat', 21:24:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:24:14 INFO - 'PWD': '/builds/slave/test', 21:24:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:24:14 INFO - 'SHELL': '/bin/bash', 21:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vupUXbCjQD/Listeners', 21:24:14 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 21:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:24:14 INFO - 'USER': 'cltbld', 21:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:24:14 INFO - 'XPC_FLAGS': '0x0', 21:24:14 INFO - 'XPC_SERVICE_NAME': '0', 21:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:24:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:24:14 INFO - mozversion application_buildid: 20161112201920 21:24:14 INFO - mozversion application_changeset: 950df3cfb7798d1c6b1f422457a0e398a2b74587 21:24:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:24:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:24:14 INFO - mozversion application_name: Firefox 21:24:14 INFO - mozversion application_remotingname: firefox-dev 21:24:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:24:14 INFO - mozversion application_vendor: Mozilla 21:24:14 INFO - mozversion application_version: 51.0a2 21:24:14 INFO - mozversion platform_buildid: 20161112201920 21:24:14 INFO - mozversion platform_changeset: 950df3cfb7798d1c6b1f422457a0e398a2b74587 21:24:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:24:14 INFO - mozversion platform_version: 51.0a2 21:24:14 INFO - using testdate: 1479014654 21:24:14 INFO - actual date: 1479014654 21:24:14 INFO - starting webserver on 'localhost:49280' 21:24:14 INFO - SUITE-START | Running 2 tests 21:24:14 INFO - TEST-START | dromaeo_css 21:24:14 INFO - operating with platform_type : mac_ 21:24:14 INFO - Initialising browser for dromaeo_css test... 21:24:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpgK72FP/profile http://localhost:49280/getInfo.html) 21:24:17 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 21:24:17 INFO - PROCESS | 1667 | colorDepth:24 21:24:17 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 21:24:17 INFO - PROCESS | 1667 | __metrics 21:24:17 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:24:17 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:24:18 INFO - TEST-INFO | 1667: exit 0 21:24:18 INFO - Browser initialized. 21:24:18 INFO - Running cycle 1/1 for dromaeo_css test... 21:24:18 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpgK72FP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:24:30 INFO - PROCESS | 1670 | RSS: Main: 220225536 21:24:30 INFO - PROCESS | 1670 | 21:25:21 INFO - PROCESS | 1670 | 1479014721507 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] 21:27:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 21:27:35 INFO - PROCESS | 1670 | RSS: Main: 362283008 21:27:35 INFO - PROCESS | 1670 | 21:30:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 21:30:38 INFO - PROCESS | 1670 | RSS: Main: 352452608 21:30:38 INFO - PROCESS | 1670 | 21:33:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 21:33:41 INFO - PROCESS | 1670 | RSS: Main: 348876800 21:33:41 INFO - PROCESS | 1670 | 21:36:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 21:36:44 INFO - PROCESS | 1670 | RSS: Main: 321486848 21:36:44 INFO - PROCESS | 1670 | 21:39:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 21:39:48 INFO - PROCESS | 1670 | RSS: Main: 310996992 21:39:48 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 21:42:51 INFO - PROCESS | 1670 | RSS: Main: 362352640 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | __start_tp_report 21:42:51 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 21:42:51 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 21:42:51 INFO - PROCESS | 1670 | |i|pagename|runs| 21:42:51 INFO - PROCESS | 1670 | |0;dojo.html;3329.084501762015;3334.216459132104;3361.9831900840477;3389.3560223557506;3417.2311229973243;5554.805581804638;5733.082706766918;5751.10857817038;5783.190353350535;5797.275340582422;5670.291213598301;5744.109663002241;5747.942520574793;5754.74103665335;5774.82675519734;5194.572210234665;5242.79028838846;5253.290805741233;5254.7635356409055;5287.365516138049;5166.17341225404;5202.219667049935;5309.522143007129;5323.9467605324035;5328.254044433782;5202.973985130069;5227.947720522784;5251.343582052244;5271.604629652772;5285.524302812746;5155.536001759822;5176.86109056009;5211.661242019257;5249.580033597341;5251.4485978972425;5153.020926024044;5183.481651834824;5213.087709650834;5219.582433405319;5254.290670759437;5624.381318055051;5636;5653.830385088454;5658.519025882805;5666.773329066832;6158.630482171084;6183.443490085869;6201.5348848836065;6202.286737025254;6209.87580248397;5508.228847961289;6357.93642063578;6372.171617689671;6379;6386.808395748135;5729.684867332337;5736.77052917887;5827.65034097947;5837.416258374129;5875.001249787546;6297.622142671455;6307.96846015767;6318.4313411793155;6320.873582528416;6323.146375239376;6190.288116866528;6216.222972128484;6219.937800621936;6220.191375121296;6235.594686345373;6147.262328520606;6169.074638804215;6184.257889053342;6208.72060757267;6285.9057114143325;6198.349173336735;6224.221972253468;6251.28110267316;6252.906206406908;6259.561830671809;6201.782937597162;6218.968905155536;6267.2792628847355;6274.215723034621;6277.748890044439;4875.1224779540025;4901.828436004723;4951.554360107608;4959.479254678206;4977.676451030671;4438;4469.173202957463;4472.127935052634;4481.462224533077;4547.977260113678;5892.793752218652;5913.9112913306335;5919.852003699856;5920.79277225295;5925.259342582177;6321.589096708699;6337.936620633827;6339.2709838368255;6342.8414289642205;6363.649999249993;5639.830805075854;5713.800016999385;5715.8571035724435;5817.0401883689565;5817.912731309034;5298.761555730001;5381.219723140122;5406.378266499324;5421.376541697677;5425.13197888336;6297.811065668037;6346.238451385679;6354.491640668735;6364.554481186457;6387.744490220339;6227.657478838526;6292;6300.432961033529;6301.243850737941;6307.306196318493;5282.234076058873;6281.528885333527;6311.431971122621;6342.23893132827;6351.015592583157;6119.6133408368505;6141.2098563120835;6152.323244443018;6250.9062364065485;6268.529860260407;5878.970605146947;6348.936510634834;6356.936430635819;6372.139761132188;6374.649394283359;5945.91081133792;6160.630362178284;6168.660723660242;6183.258009038944;6185.103160041859;5980.850478738066;6048.36492168316;6074.149619053424;6110.194261626952;6112.235970503687;6045.486133678686;6052.90920636182;6058.5153187745755;6060.606060606046;6097.085437184458;6151.384861513991;6166.691665416622;6183.319834818257;6188.257409110935;6209.875802483834;5803.912941305799;5829.183914251923;5850.765969361178;5890.322612899571;5972.970135149297 21:42:51 INFO - PROCESS | 1670 | |1;ext.html;483.3373196205054;486.5718168012149;521.937367515898;534.9491798279162;539.0431983229767;30441.847790761043;31457.370852582935;40016;41078.794606027004;41267.58732412675;43536;43743.56256437435;43744.562554374446;43871.56128438715;43878.12243755123;9863.60545578176;10065.597376104946;10067.69796906094;10070.949645251763;10071.748206294864;9963.302568820185;10065.245106616996;10066.446345450997;10074.74813129674;10079;10027.548760305805;10086.394816311045;10097.798044039115;10113.595456181743;10127.088562029416;10073.647422340257;10084.596616135346;10085.798284034277;10087.596496140146;10109.797804043914;9898.307118501636;9950.502474876299;9959.601615935426;9959.950200248952;9980.101790838788;40963.59036409628;41194.38208426876;41266.79366603178;41294.79352603248;41353.58646413557;3413.385590593692;3767.9786624124326;4030.5163380394247;4035.778032208227;4123.505179378464;30495.542566861513;30561.23596910073;31655.84172079125;32732.836335818167;32744.508832367534;3109.4046095385615;3178.6503484616674;3210.2455922858107;3219.7263232625255;3251.5935508061493;532071;532543;533164.3341783305;533386;534803;64260.35739642637;64921.67539162274;64968.67515662486;65086.023709644396;65091.349086508526;34659.96020119401;34950.82524587412;35234;36290.45564316538;36306.45540316898;16245.593860153354;16307;16411.93322434038;16419.1790410479;16517.58706032335;12483.063770217088;12562.246265224116;12566.05754568411;12573.497060117676;12585.307808070644;19137.425877223704;19308.03459827031;19314.613707725766;19315.710264346046;19316.32392866243;7844.333231675371;7857.332126769289;7864.764057078182;7986.720464783704;8052.315553177928;721.4192574977089;884.2174675412307;886.6763631274538;969.0842154164388;1002.8094662014194;26860.59709104365;29345.413091738472;29921.102366929026;30035.64483149931;30644.69355306463;860.819227962135;955.4506158958627;996.5814357969671;1029.1715169288645;1070.9518071686794;12919.741605167845;15590.532284031497;15646.9217653911;15853.207339633203;16052.598685032968;659944.7002764955;668978;669856;670167;670327;59332;59697;59799.10301345396;59812;59888.40111598915;1110.8666959964694;1204.9939750301369;1251.6557946564585;1393.303348325837;1397.2734178227063;27333.633318334403;30203.697963020088;31239.06282811519;31282.374352513278;32541.837290813393;50732.492675072775;51450.74274628603;51455.48544514507;51477.97044059023;51511.2273315893;587387;594503;594664;594710;595294;27040.45919081568;27760.722392775813;27876.44247115087;28665.423401713106;28702.42595148127;48109.75945120252;48586.5141348582;48854.534363969135;48900.75549622229;49128.50871491382;39039.88175785358;40147;40231.59768402279;41503;41654.37518437287;35937.74217902361;36941;39244.80377598094;39650;41158.588414115475;37456.2508749818;39000.41499377568;39424.40863386994;39512.40731388974;39559.80220098881;32478.675213247567;34600.307993840484;35113.47329790004;35227;35263.47104793379;22486.212982545534;24677;25301.746982529938;25656.102036428634;25949 21:42:51 INFO - PROCESS | 1670 | |2;jquery.html;320.61366053905044;342.5307328959326;347.6853447629896;381.89497888080774;408.4383972038447;15259.23703814809;15344.846551534481;16451.83548164518;20883.269085582007;21037.26515552976;17840.553986150353;20452.795472045276;20526.178952841867;20661.380158595268;20673.896630516825;5782.624129431584;6025.9096113558335;6031.547633927473;6031.607945483552;6043.305019922721;3969.186316805048;5944;5998.40015998401;6010.8497287567725;6024.126501657257;5669.489745922866;5951.49412299955;5957;5957.1659967604355;5964.701764911759;5778.768849246025;5779.739911703983;5878.1476685880525;5880.029795083806;5891.734871930774;5126.5642420394315;5139.306193663845;5141.408737995103;5279.392869819982;5502.532284755801;13246.40391182399;13399.598012059654;13449.26029068401;13492.460301587924;22009.889950550303;2097.760378822703;2207.260567709819;2221.8777967211795;2263.8302127340517;2290.461741490765;9734.269929755297;9851.507424628811;10028.749281267954;10156.136728378096;10391.740206494822;1628.6986907422047;1833.6607727570442;1925.5763731978943;1934.4390126863193;2029.9086541105685;114280.42859785732;118208;119914;120088.39955800252;126094.73905261014;11080.778384432428;11133.498992545356;11295.604653837241;11752.059835213162;11904.821427678591;14607.269636518131;14613.342399592044;14626.902982276159;14634.195119268543;14644.414223431157;7704.922950770532;8045.436819422701;8415;8533.359998000175;8584.699535516227;6996.860062798715;8146.7148649798155;8210.753677389688;8291.709790157316;8502.659893604186;4112.403701463331;4511.548845115528;4567.611753000966;4600.976995115003;4628.213203755302;1851.759271294723;1888.2824526679774;1898.7626546681665;1900.116445852685;1901.1919934027983;815.1807433529265;840.8990921089509;853.1553761775797;908.8732366262976;995.049727510226;20751.377458676263;21169.894150529148;21253.89373053125;21282.574348512942;21338.57322853534;895.9955200224088;898.5641963647626;903.8282726281985;907.4782000349825;915.6291701860757;10552.472376381304;11143.275687080313;11170.329780213213;11192.328460292245;11216.102711783202;533089;535197;536362;608324;647979;84632.76836158168;143778.2811085938;146579.80130298054;149625;150939;945.9810803783886;960.3805545423163;1004.2719028704277;1005.607812952949;1007.1791489935825;18296.268149274412;18708.625827483647;19047.809521904604;19110.426687199408;19403;35758;53033.46966530285;53281.4671853292;55808;57058;79538;79774.20225797668;80732.59633701794;81602.77595835949;81964;7938.126806051214;8043.19568043191;8145.633446494803;8174.427790054877;8189.79525511867;12156.878431215575;12549.749005019667;12770.489180432678;12983.285919274153;13019.609411717664;10838.187135964992;10886.183536234972;10901.945490272497;11177.441127943734;11230;9886.653967111117;9892.356996795184;10361.44578313259;10568.207384446043;10702.678919632424;11098.5560577576;11137.665870023913;11509;11570.421478926188;11610.187286889837;7888.566128862968;7974.92025079765;7984.600769961363;8104.108548059827;8148.981377327834;10731.356118632906;11071.114310855273;11103.38931358783;11139.610113645984;11548.653540393801 21:42:51 INFO - PROCESS | 1670 | |3;mootools.html;1361.7548841208584;1543.4212170436083;1737.9478615641526;1870.1210431097397;1933.8839669619824;8437.746867593974;8980.146886045823;8982.730518084469;8982.955085224581;9008.0541543138;7763;8064.9596752016305;8065.959670201641;8160.877586836202;8166.754997350089;2156.1914282144235;2305.0664480885184;2367.159658321297;2374.7150341958904;2390.282915125464;2393.5212957408503;2394.3295877154337;2420.7942324902406;2422.63660450932;2424.7211570669333;2418.5283869645427;2422.4549476367765;2425.721042080157;2426.5268272686835;2426.708794944609;2366.692329997098;2409.1688367513266;2412.4560281419904;2412.6381042843714;2415.9396015099587;2390.3665528634924;2395.377201927494;2405.2183040511727;2412.867292298923;2414.5050264695697;8765.386422950396;8944.597493112826;8952.597133129026;8956.955215223883;8967.730968070968;4924.433690125646;5018.222175562793;5217.113090774577;5354.544863686591;5371.543418809367;3171.4925611901986;3572.517710109128;3661.505696730934;3710.684591809699;3723.7765734055774;1064.6539874540729;1099.8185299425586;1121.344013751956;1124.3254047571393;1128.9491972861158;9745.512724363824;11205;11504.42477876103;11540.365279909602;11724.531018759239;4158.9584104158575;4473.977630111894;4527.845399423126;4559.658025648023;4666.976665116721;7877.645505952246;7890.132085470594;9146.496942668216;9161.221296189899;9220.8616870747;5203.505666961632;5206.349206349207;5208.192730126836;5213.348331458567;5218.869528261824;4653.790579423934;4795.160846851787;4847.733374664427;4849.102915960559;4864.975675121602;3686.4838922550866;3714.5728241252064;3741.2704522618374;3764.8305826237884;3824.4263360496147;1146.295028557448;1157.114807172497;1158.6060739348661;1162.1632424654235;1169.9883001169878;762.1083332500987;860.8020155364176;901.8511945528915;915.7573243090586;920.3925409229876;5780.306363236438;5821.76712931478;5874.471297583153;5946.286445626552;6107.816765497042;785.3560080733744;930.7905721212672;957.6313119448923;965.75856035991;1000.3747657713928;3965.6629186518894;4037.878863634037;4053.858114965962;4148.460700108966;4161.292580261363;10386.221033422524;10850.457477126112;10855.294405863593;10869.34783912952;10881.12950963921;10078.395296282246;10321.793564128826;10782.137429005661;10808.135349172047;10808.94595527033;8049.597520123971;8242.29940455068;8259.876101858477;8262.958685206535;8271.8345633087;5926.407359264039;6033.456988871023;6044.486218671462;6163.506919446523;6170.50635949114;9656;9730.416175029237;9787.951060244653;9969.451680157661;10004.599816007569;10161.644342447978;10329.74175645615;10345.534450949875;10347.63783267582;10361.533730981973;5882.058870580687;6963.442924566124;7176.820579485555;7182.3535881770895;7186.173590037003;8152.877706834283;8549.145085491402;8553.914460855312;8565.400421970402;8569.571521424028;7376.7786966391095;7555.508891922007;7606.315431611181;7667.616619169131;7763.883541746765;7349.522281051714;7471.066116735408;7493.40052795786;7512.098548174254;7563.924360756322;7045.506814522934;7164.641767911479;7169.4981351307;7173.784786456415;7179.712811487482;4853.975730121327;4955.281484184845;4975.6019518437715;5028.899422011613;5196.766145523537;4835.564799168092;4933.210686290176;4948.480409556944;4996.050750357421;5160.535551800206 21:42:51 INFO - PROCESS | 1670 | |4;prototype.html;301.7028227196211;302.3227969348659;309.76457892002077;314.36027683663735;315.5109580150766;4104.425380446736;4274.252005898971;5312.335958005249;5324.62727609067;5389.846939540369;5051.9539586467445;5059.822906198275;5219.191025391061;5236.1098613235745;5379.6503227290195;4066.6543343815665;4077.8368865245357;4077.979610101953;4109.260333140033;4111.527174374955;4072.75563466193;4081.2245673321972;4093.897652558695;4118;4178.6657067434535;3788.734788564788;3911.3546264866263;4014.6988975826785;4065;4081.3469844824835;4017.8392864285393;4028.2950483665536;4064.2726841092417;4067.877963661095;4073.775942323171;3464.2725027744204;3470.6008808986785;3475.4265546184847;3482.1294676330917;3505.4216054351;4848.5151484851585;4978.8257410990445;5228.424873263938;5277.419483856773;5299.5230429261555;4570.349197465495;4580.748058856761;4588.7246765194195;4598.574441923015;4626.699264547794;4951.628627852925;5583.4137415571595;5585.553155747531;5590.916136257919;5592.552595792326;3786.8828695534885;3832.2335532893535;3837.4435706822633;3842.50047493824;3848.5958974307573;3641.362761516724;4916.483769204254;4943.777530011158;5903.498202652822;5929.792457263975;3603.279344131184;3839.310703290543;3862.980685096613;3874.3219936511;3885;3652.8448215552953;3937.7161246476976;3942.541259733917;3961.623645753649;3968.8809335719975;4333.414988976448;4575.382323386367;4618.445786505641;4638.3070179384285;4673.392458980311;5648.576356773258;5651.208830763697;5657.377688454267;5660.518855897212;5670;1098.083100610983;1121.5401685308984;1303.843538775334;1308.8560258371572;1348.2112963916022;713.8429545500086;921.5346250143634;939.145377706284;953.5041778275258;959.2661613865398;4618.2841659542155;5075.695458272516;5299.629025968223;5308.548773354231;5361.92761447712;5678.914816277676;5696.202531645573;5728.255326807572;5768.538516918637;5793.246877905845;4982.501749824988;5273.551748101378;5284.39229488606;5293.973530132324;5305.6551324164575;2439.4023464251372;3038.2708150044273;3040.9847950760104;3060.515649909792;3062.6784187659973;4924.729139897268;5001.624878134155;5179.056837410818;5983.042713165873;6047.365026672224;5160.716160611128;5722.027255366597;5784.248047753765;5801.564882633819;5809.157672137517;4978.60171186297;5832.037713777264;5852.678102704393;5879.559033072536;5906.320773111147;4629.231891152119;5035.874103147451;5221.295125158207;5586.597762961803;5764.654120752768;4741.407324084489;5620.241267429008;5625.803096891589;5629.228416960728;5670.914936276042;5133.076046311699;5584.743432727604;5894.440028197314;5946.524278057658;6043.637381757108;3457.9135521611156;3728.7135938102397;3937.370020796773;3956.663683586927;4000.3999400089056;5147.871303217449;5185.248139019896;5196.68819870809;5660;5811.53507719373;4905.688073394495;4995.650304478651;5629.6903670298525;5630.63400878958;5707.4577915098;4684.016356565159;4837.250226214942;5389.2455056291365;5521.447855214607;5567.220589117445;4958.305837182726;5158.793648254028;5171.5609119934825;5434.891302174014;5444.292242008672;5227.764750586157;5392.570968693378;5393.921215756786;5524.66851988882;5701.458361455655;4857.587105096107;5443.972780136074;5594.916076258941;5668.773249069991;5706.714664266853 21:42:51 INFO - PROCESS | 1670 | |5;yui.html;699.8565294114704;714.2607401339613;762.0931092000519;783.2559068884558;822.8107535266885;15585.220738963064;16562.917185414088;16585.91707041466;16600.920940138883;16660.416885409013;14717.264136793172;14776.113433194016;14782.630434239149;14794.038387504805;14845;689.3175756001573;705.0869124483805;853.1255463150259;853.624405261686;875.9956200219021;862.7153039496951;865.9263962563158;874.9475031498099;875.6978842299396;877.4165180155189;906.4833045164258;931.0921851195098;931.78568929146;932.9877083364557;934.2946075712862;723.2550473012806;741.3290971670647;923.1968187676697;923.8937522184934;924.2836801478841;666.9599824010575;677.7864972533686;681.3527149208222;691.6265216782931;694.506900100929;12477.812832807514;15206.847931520653;15426.922865385714;15471.22643867802;15493.302801373853;13916.860831391657;14216.573502794932;14371.640708982255;14442.494512692005;14452.710945781026;12475.937620311932;12581;12768.233905965672;13149.605511834565;13379.732405351935;4623.884402889921;4628.930566041512;4728.8507561990355;4778.331033655291;4809.903801923977;117603;119305.80694193034;120453.5909281827;120901.39549302285;121848.78151218464;9592.904070959341;11122.777544449065;11292.604758833566;11396.829047564293;11403.657890263305;22532.436689082904;22579.548409031726;22651.320460386214;22753;22762.975666094735;7841.372690184771;8067.031956165298;8067.314278286294;8235.21765432283;8262.669493220204;4195.559466256061;4271.444712187395;4294.398784170218;4359.06280149763;4383.846565370197;3528.4883691864534;3604.2971620533744;3606.945895811565;3608.6030536640947;3614.8373323200517;560.7700842654492;634.996825015872;640.5580149696694;641.6118248459708;642.0722056628221;557.8633234857405;627.6547898655721;628.1802248066226;638.5434414393638;641.5541198866836;8556.868287730524;8911.55442227886;9077.636894524278;9240.168384845396;9269.119433653792;563.5284021291069;612.4120843989731;617.6325086573481;631.3339426904568;654.2900952466532;4264.850730224489;4480.641548676098;4491.505934347219;4514.300283456069;4539.909201816011;110427.34358984622;120694.15487993252;160809.19595402182;161601.19199403928;166516;38144.809275953994;38537.614623853406;38625.61374386276;38634;66345;77531.61234193793;88211.55894220488;108919.91080089098;126751.73248267584;129634.35182824025;7688.577128258;7981.002374703162;8136.180897012383;8690.565471726515;8703.390762646553;64162;66175.66912165408;66279.0174442161;66765.66617167077;66944.3305566938;80299;96234.37656234321;102724.97275027154;105274.42088368833;109447;11601.553371024043;11711.531538738354;11744.70638234051;11756.647300580997;12112.576059837864;11638.825417618573;11873.397091392551;12100.636980890587;12714.046446516364;12901.161424507753;11419.31484110956;11596.785916979627;12016.63950081499;12148.939255303667;12198.51205951752;11615.245009074382;11652.94173529127;11690.649280521598;11884.821727674265;12452.688682783002;11398.601048963577;11692.532298708296;11801.586944456903;11886.34625095628;12555.93722031384;9560.187384072431;9637.566309515949;9652.420854748456;9665.71002869915;10002.849957250794;9590.436528148148;9822.607095716092;9841.507924603598;9886.802263954825;9899.851502227617 21:42:51 INFO - PROCESS | 1670 | __end_tp_report 21:42:51 INFO - PROCESS | 1670 | __start_cc_report 21:42:51 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1272 21:42:51 INFO - PROCESS | 1670 | __end_cc_report 21:42:51 INFO - PROCESS | 1670 | __startTimestamp1479015771413__endTimestamp 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | ------- Summary: start ------- 21:42:51 INFO - PROCESS | 1670 | Number of tests: 6 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5768.63 Median:5945.91 stddev:643.53 (10.8%) stddev-sans-first:616.39 21:42:51 INFO - PROCESS | 1670 | Values: 3329.1 3334.2 3362.0 3389.4 3417.2 5554.8 5733.1 5751.1 5783.2 5797.3 5670.3 5744.1 5747.9 5754.7 5774.8 5194.6 5242.8 5253.3 5254.8 5287.4 5166.2 5202.2 5309.5 5323.9 5328.3 5203.0 5227.9 5251.3 5271.6 5285.5 5155.5 5176.9 5211.7 5249.6 5251.4 5153.0 5183.5 5213.1 5219.6 5254.3 5624.4 5636.0 5653.8 5658.5 5666.8 6158.6 6183.4 6201.5 6202.3 6209.9 5508.2 6357.9 6372.2 6379.0 6386.8 5729.7 5736.8 5827.7 5837.4 5875.0 6297.6 6308.0 6318.4 6320.9 6323.1 6190.3 6216.2 6219.9 6220.2 6235.6 6147.3 6169.1 6184.3 6208.7 6285.9 6198.3 6224.2 6251.3 6252.9 6259.6 6201.8 6219.0 6267.3 6274.2 6277.7 4875.1 4901.8 4951.6 4959.5 4977.7 4438.0 4469.2 4472.1 4481.5 4548.0 5892.8 5913.9 5919.9 5920.8 5925.3 6321.6 6337.9 6339.3 6342.8 6363.6 5639.8 5713.8 5715.9 5817.0 5817.9 5298.8 5381.2 5406.4 5421.4 5425.1 6297.8 6346.2 6354.5 6364.6 6387.7 6227.7 6292.0 6300.4 6301.2 6307.3 5282.2 6281.5 6311.4 6342.2 6351.0 6119.6 6141.2 6152.3 6250.9 6268.5 5879.0 6348.9 6356.9 6372.1 6374.6 5945.9 6160.6 6168.7 6183.3 6185.1 5980.9 6048.4 6074.1 6110.2 6112.2 6045.5 6052.9 6058.5 6060.6 6097.1 6151.4 6166.7 6183.3 6188.3 6209.9 5803.9 5829.2 5850.8 5890.3 5973.0 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:72375.97 Median:37198.63 stddev:160698.92 (432.0%) stddev-sans-first:161059.07 21:42:51 INFO - PROCESS | 1670 | Values: 483.3 486.6 521.9 534.9 539.0 30441.8 31457.4 40016.0 41078.8 41267.6 43536.0 43743.6 43744.6 43871.6 43878.1 9863.6 10065.6 10067.7 10070.9 10071.7 9963.3 10065.2 10066.4 10074.7 10079.0 10027.5 10086.4 10097.8 10113.6 10127.1 10073.6 10084.6 10085.8 10087.6 10109.8 9898.3 9950.5 9959.6 9960.0 9980.1 40963.6 41194.4 41266.8 41294.8 41353.6 3413.4 3768.0 4030.5 4035.8 4123.5 30495.5 30561.2 31655.8 32732.8 32744.5 3109.4 3178.7 3210.2 3219.7 3251.6 532071.0 532543.0 533164.3 533386.0 534803.0 64260.4 64921.7 64968.7 65086.0 65091.3 34660.0 34950.8 35234.0 36290.5 36306.5 16245.6 16307.0 16411.9 16419.2 16517.6 12483.1 12562.2 12566.1 12573.5 12585.3 19137.4 19308.0 19314.6 19315.7 19316.3 7844.3 7857.3 7864.8 7986.7 8052.3 721.4 884.2 886.7 969.1 1002.8 26860.6 29345.4 29921.1 30035.6 30644.7 860.8 955.5 996.6 1029.2 1071.0 12919.7 15590.5 15646.9 15853.2 16052.6 659944.7 668978.0 669856.0 670167.0 670327.0 59332.0 59697.0 59799.1 59812.0 59888.4 1110.9 1205.0 1251.7 1393.3 1397.3 27333.6 30203.7 31239.1 31282.4 32541.8 50732.5 51450.7 51455.5 51478.0 51511.2 587387.0 594503.0 594664.0 594710.0 595294.0 27040.5 27760.7 27876.4 28665.4 28702.4 48109.8 48586.5 48854.5 48900.8 49128.5 39039.9 40147.0 40231.6 41503.0 41654.4 35937.7 36941.0 39244.8 39650.0 41158.6 37456.3 39000.4 39424.4 39512.4 39559.8 32478.7 34600.3 35113.5 35227.0 35263.5 22486.2 24677.0 25301.7 25656.1 25949.0 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:34164.70 Median:2242.85 stddev:96516.55 (4303.3%) stddev-sans-first:96753.85 21:42:51 INFO - PROCESS | 1670 | Values: 320.6 342.5 347.7 381.9 408.4 15259.2 15344.8 16451.8 20883.3 21037.3 17840.6 20452.8 20526.2 20661.4 20673.9 5782.6 6025.9 6031.5 6031.6 6043.3 3969.2 5944.0 5998.4 6010.8 6024.1 5669.5 5951.5 5957.0 5957.2 5964.7 5778.8 5779.7 5878.1 5880.0 5891.7 5126.6 5139.3 5141.4 5279.4 5502.5 13246.4 13399.6 13449.3 13492.5 22009.9 2097.8 2207.3 2221.9 2263.8 2290.5 9734.3 9851.5 10028.7 10156.1 10391.7 1628.7 1833.7 1925.6 1934.4 2029.9 114280.4 118208.0 119914.0 120088.4 126094.7 11080.8 11133.5 11295.6 11752.1 11904.8 14607.3 14613.3 14626.9 14634.2 14644.4 7704.9 8045.4 8415.0 8533.4 8584.7 6996.9 8146.7 8210.8 8291.7 8502.7 4112.4 4511.5 4567.6 4601.0 4628.2 1851.8 1888.3 1898.8 1900.1 1901.2 815.2 840.9 853.2 908.9 995.0 20751.4 21169.9 21253.9 21282.6 21338.6 896.0 898.6 903.8 907.5 915.6 10552.5 11143.3 11170.3 11192.3 11216.1 533089.0 535197.0 536362.0 608324.0 647979.0 84632.8 143778.3 146579.8 149625.0 150939.0 946.0 960.4 1004.3 1005.6 1007.2 18296.3 18708.6 19047.8 19110.4 19403.0 35758.0 53033.5 53281.5 55808.0 57058.0 79538.0 79774.2 80732.6 81602.8 81964.0 7938.1 8043.2 8145.6 8174.4 8189.8 12156.9 12549.7 12770.5 12983.3 13019.6 10838.2 10886.2 10901.9 11177.4 11230.0 9886.7 9892.4 10361.4 10568.2 10702.7 11098.6 11137.7 11509.0 11570.4 11610.2 7888.6 7974.9 7984.6 8104.1 8149.0 10731.4 11071.1 11103.4 11139.6 11548.7 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5656.26 Median:4951.88 stddev:3133.24 (63.3%) stddev-sans-first:3125.40 21:42:51 INFO - PROCESS | 1670 | Values: 1361.8 1543.4 1737.9 1870.1 1933.9 8437.7 8980.1 8982.7 8983.0 9008.1 7763.0 8065.0 8066.0 8160.9 8166.8 2156.2 2305.1 2367.2 2374.7 2390.3 2393.5 2394.3 2420.8 2422.6 2424.7 2418.5 2422.5 2425.7 2426.5 2426.7 2366.7 2409.2 2412.5 2412.6 2415.9 2390.4 2395.4 2405.2 2412.9 2414.5 8765.4 8944.6 8952.6 8957.0 8967.7 4924.4 5018.2 5217.1 5354.5 5371.5 3171.5 3572.5 3661.5 3710.7 3723.8 1064.7 1099.8 1121.3 1124.3 1128.9 9745.5 11205.0 11504.4 11540.4 11724.5 4159.0 4474.0 4527.8 4559.7 4667.0 7877.6 7890.1 9146.5 9161.2 9220.9 5203.5 5206.3 5208.2 5213.3 5218.9 4653.8 4795.2 4847.7 4849.1 4865.0 3686.5 3714.6 3741.3 3764.8 3824.4 1146.3 1157.1 1158.6 1162.2 1170.0 762.1 860.8 901.9 915.8 920.4 5780.3 5821.8 5874.5 5946.3 6107.8 785.4 930.8 957.6 965.8 1000.4 3965.7 4037.9 4053.9 4148.5 4161.3 10386.2 10850.5 10855.3 10869.3 10881.1 10078.4 10321.8 10782.1 10808.1 10808.9 8049.6 8242.3 8259.9 8263.0 8271.8 5926.4 6033.5 6044.5 6163.5 6170.5 9656.0 9730.4 9788.0 9969.5 10004.6 10161.6 10329.7 10345.5 10347.6 10361.5 5882.1 6963.4 7176.8 7182.4 7186.2 8152.9 8549.1 8553.9 8565.4 8569.6 7376.8 7555.5 7606.3 7667.6 7763.9 7349.5 7471.1 7493.4 7512.1 7563.9 7045.5 7164.6 7169.5 7173.8 7179.7 4854.0 4955.3 4975.6 5028.9 5196.8 4835.6 4933.2 4948.5 4996.1 5160.5 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4510.19 Median:5018.75 stddev:1368.42 (27.3%) stddev-sans-first:1335.31 21:42:51 INFO - PROCESS | 1670 | Values: 301.7 302.3 309.8 314.4 315.5 4104.4 4274.3 5312.3 5324.6 5389.8 5052.0 5059.8 5219.2 5236.1 5379.7 4066.7 4077.8 4078.0 4109.3 4111.5 4072.8 4081.2 4093.9 4118.0 4178.7 3788.7 3911.4 4014.7 4065.0 4081.3 4017.8 4028.3 4064.3 4067.9 4073.8 3464.3 3470.6 3475.4 3482.1 3505.4 4848.5 4978.8 5228.4 5277.4 5299.5 4570.3 4580.7 4588.7 4598.6 4626.7 4951.6 5583.4 5585.6 5590.9 5592.6 3786.9 3832.2 3837.4 3842.5 3848.6 3641.4 4916.5 4943.8 5903.5 5929.8 3603.3 3839.3 3863.0 3874.3 3885.0 3652.8 3937.7 3942.5 3961.6 3968.9 4333.4 4575.4 4618.4 4638.3 4673.4 5648.6 5651.2 5657.4 5660.5 5670.0 1098.1 1121.5 1303.8 1308.9 1348.2 713.8 921.5 939.1 953.5 959.3 4618.3 5075.7 5299.6 5308.5 5361.9 5678.9 5696.2 5728.3 5768.5 5793.2 4982.5 5273.6 5284.4 5294.0 5305.7 2439.4 3038.3 3041.0 3060.5 3062.7 4924.7 5001.6 5179.1 5983.0 6047.4 5160.7 5722.0 5784.2 5801.6 5809.2 4978.6 5832.0 5852.7 5879.6 5906.3 4629.2 5035.9 5221.3 5586.6 5764.7 4741.4 5620.2 5625.8 5629.2 5670.9 5133.1 5584.7 5894.4 5946.5 6043.6 3457.9 3728.7 3937.4 3956.7 4000.4 5147.9 5185.2 5196.7 5660.0 5811.5 4905.7 4995.7 5629.7 5630.6 5707.5 4684.0 4837.3 5389.2 5521.4 5567.2 4958.3 5158.8 5171.6 5434.9 5444.3 5227.8 5392.6 5393.9 5524.7 5701.5 4857.6 5444.0 5594.9 5668.8 5706.7 21:42:51 INFO - PROCESS | 1670 | 21:42:51 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:22617.28 Median:4432.24 stddev:36690.50 (827.8%) stddev-sans-first:36756.52 21:42:51 INFO - PROCESS | 1670 | Values: 699.9 714.3 762.1 783.3 822.8 15585.2 16562.9 16585.9 16600.9 16660.4 14717.3 14776.1 14782.6 14794.0 14845.0 689.3 705.1 853.1 853.6 876.0 862.7 865.9 874.9 875.7 877.4 906.5 931.1 931.8 933.0 934.3 723.3 741.3 923.2 923.9 924.3 667.0 677.8 681.4 691.6 694.5 12477.8 15206.8 15426.9 15471.2 15493.3 13916.9 14216.6 14371.6 14442.5 14452.7 12475.9 12581.0 12768.2 13149.6 13379.7 4623.9 4628.9 4728.9 4778.3 4809.9 117603.0 119305.8 120453.6 120901.4 121848.8 9592.9 11122.8 11292.6 11396.8 11403.7 22532.4 22579.5 22651.3 22753.0 22763.0 7841.4 8067.0 8067.3 8235.2 8262.7 4195.6 4271.4 4294.4 4359.1 4383.8 3528.5 3604.3 3606.9 3608.6 3614.8 560.8 635.0 640.6 641.6 642.1 557.9 627.7 628.2 638.5 641.6 8556.9 8911.6 9077.6 9240.2 9269.1 563.5 612.4 617.6 631.3 654.3 4264.9 4480.6 4491.5 4514.3 4539.9 110427.3 120694.2 160809.2 161601.2 166516.0 38144.8 38537.6 38625.6 38634.0 66345.0 77531.6 88211.6 108919.9 126751.7 129634.4 7688.6 7981.0 8136.2 8690.6 8703.4 64162.0 66175.7 66279.0 66765.7 66944.3 80299.0 96234.4 102725.0 105274.4 109447.0 11601.6 11711.5 11744.7 11756.6 12112.6 11638.8 11873.4 12100.6 12714.0 12901.2 11419.3 11596.8 12016.6 12148.9 12198.5 11615.2 11652.9 11690.6 11884.8 12452.7 11398.6 11692.5 11801.6 11886.3 12555.9 9560.2 9637.6 9652.4 9665.7 10002.8 9590.4 9822.6 9841.5 9886.8 9899.9 21:42:51 INFO - PROCESS | 1670 | -------- Summary: end -------- 21:42:51 INFO - PROCESS | 1670 | 21:42:52 INFO - TEST-INFO | 1670: exit 0 21:42:52 INFO - TEST-OK | dromaeo_css | took 1117490ms 21:42:52 INFO - TEST-START | kraken 21:42:52 INFO - operating with platform_type : mac_ 21:42:52 INFO - Initialising browser for kraken test... 21:42:52 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp3hp0Ft/profile http://localhost:49280/getInfo.html) 21:42:54 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 21:42:54 INFO - PROCESS | 1677 | colorDepth:24 21:42:54 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 21:42:54 INFO - PROCESS | 1677 | __metrics 21:42:54 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:42:54 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:55 INFO - TEST-INFO | 1677: exit 0 21:42:55 INFO - Browser initialized. 21:42:55 INFO - Running cycle 1/1 for kraken test... 21:42:55 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmp3hp0Ft/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:43:07 INFO - PROCESS | 1678 | RSS: Main: 220319744 21:43:07 INFO - PROCESS | 1678 | 21:43:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 21:43:11 INFO - PROCESS | 1678 | RSS: Main: 271421440 21:43:11 INFO - PROCESS | 1678 | 21:43:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 21:43:14 INFO - PROCESS | 1678 | RSS: Main: 282324992 21:43:14 INFO - PROCESS | 1678 | 21:43:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 21:43:18 INFO - PROCESS | 1678 | RSS: Main: 379092992 21:43:18 INFO - PROCESS | 1678 | 21:43:20 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 21:43:20 INFO - PROCESS | 1678 | RSS: Main: 279531520 21:43:20 INFO - PROCESS | 1678 | 21:43:22 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:43:23 INFO - PROCESS | 1678 | RSS: Main: 281014272 21:43:23 INFO - PROCESS | 1678 | 21:43:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 21:43:26 INFO - PROCESS | 1678 | RSS: Main: 318164992 21:43:26 INFO - PROCESS | 1678 | 21:43:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 21:43:30 INFO - PROCESS | 1678 | RSS: Main: 319700992 21:43:30 INFO - PROCESS | 1678 | 21:43:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 21:43:33 INFO - PROCESS | 1678 | RSS: Main: 319275008 21:43:33 INFO - PROCESS | 1678 | 21:43:35 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:43:35 INFO - PROCESS | 1678 | RSS: Main: 296067072 21:43:35 INFO - PROCESS | 1678 | 21:43:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:43:38 INFO - PROCESS | 1678 | RSS: Main: 297820160 21:43:38 INFO - PROCESS | 1678 | 21:43:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:43:41 INFO - PROCESS | 1678 | RSS: Main: 301944832 21:43:41 INFO - PROCESS | 1678 | 21:43:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:43:44 INFO - PROCESS | 1678 | RSS: Main: 329326592 21:43:44 INFO - PROCESS | 1678 | 21:43:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:43:48 INFO - PROCESS | 1678 | RSS: Main: 316948480 21:43:48 INFO - PROCESS | 1678 | 21:43:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 21:43:50 INFO - PROCESS | 1678 | RSS: Main: 360484864 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | __start_tp_report 21:43:50 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 21:43:50 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 21:43:50 INFO - PROCESS | 1678 | |i|pagename|runs| 21:43:50 INFO - PROCESS | 1678 | |0;ai-astar;115;116;121;167;162;114;113;115;114;114 21:43:50 INFO - PROCESS | 1678 | |1;audio-beat-detection;141;109;110;143;111;110;107;109;140;116 21:43:50 INFO - PROCESS | 1678 | |2;audio-dft;184;187;185;185;182;184;182;182;186;182 21:43:50 INFO - PROCESS | 1678 | |3;audio-fft;83;58;59;89;63;72;81;82;83;57 21:43:50 INFO - PROCESS | 1678 | |4;audio-oscillator;86;70;94;70;68;69;92;68;69;90 21:43:50 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;85;88;84;87;84;89;84;86;85 21:43:50 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;95;95;95;95;96;96;95;99;94 21:43:50 INFO - PROCESS | 1678 | |7;imaging-desaturate;86;83;85;84;84;84;84;85;84;85 21:43:50 INFO - PROCESS | 1678 | |8;json-parse-financial;55;53;53;52;53;57;79;87;88;85 21:43:50 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;78;80;78;74;69;70;72;70;73 21:43:50 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;82;85;84;84;82;83;82;86;89;99 21:43:50 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;151;143;140;145;147;135;136;139;141;138 21:43:50 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;163;165;163;162;164;165;161;166;162;173 21:43:50 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;68;65;80;85;85;85;82;71;63;65 21:43:50 INFO - PROCESS | 1678 | __end_tp_report 21:43:50 INFO - PROCESS | 1678 | __start_cc_report 21:43:50 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1958 21:43:50 INFO - PROCESS | 1678 | __end_cc_report 21:43:50 INFO - PROCESS | 1678 | __startTimestamp1479015830152__endTimestamp 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | ------- Summary: start ------- 21:43:50 INFO - PROCESS | 1678 | Number of tests: 14 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:125.10 Median:115.50 stddev:20.91 (18.1%) stddev-sans-first:21.86 21:43:50 INFO - PROCESS | 1678 | Values: 115.0 116.0 121.0 167.0 162.0 114.0 113.0 115.0 114.0 114.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:113.50 stddev:15.19 (13.4%) stddev-sans-first:14.00 21:43:50 INFO - PROCESS | 1678 | Values: 141.0 109.0 110.0 143.0 111.0 110.0 107.0 109.0 140.0 116.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.85 (1.0%) stddev-sans-first:1.96 21:43:50 INFO - PROCESS | 1678 | Values: 184.0 187.0 185.0 185.0 182.0 184.0 182.0 182.0 186.0 182.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:72.70 Median:81.50 stddev:12.37 (15.2%) stddev-sans-first:12.55 21:43:50 INFO - PROCESS | 1678 | Values: 83.0 58.0 59.0 89.0 63.0 72.0 81.0 82.0 83.0 57.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:11.30 (14.5%) stddev-sans-first:11.57 21:43:50 INFO - PROCESS | 1678 | Values: 86.0 70.0 94.0 70.0 68.0 69.0 92.0 68.0 69.0 90.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.50 stddev:1.89 (2.2%) stddev-sans-first:1.86 21:43:50 INFO - PROCESS | 1678 | Values: 88.0 85.0 88.0 84.0 87.0 84.0 89.0 84.0 86.0 85.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 21:43:50 INFO - PROCESS | 1678 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 99.0 94.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 21:43:50 INFO - PROCESS | 1678 | Values: 86.0 83.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:68.00 stddev:16.19 (23.8%) stddev-sans-first:16.66 21:43:50 INFO - PROCESS | 1678 | Values: 55.0 53.0 53.0 52.0 53.0 57.0 79.0 87.0 88.0 85.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:73.50 stddev:4.52 (6.2%) stddev-sans-first:4.02 21:43:50 INFO - PROCESS | 1678 | Values: 66.0 78.0 80.0 78.0 74.0 69.0 70.0 72.0 70.0 73.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:5.19 (6.1%) stddev-sans-first:5.34 21:43:50 INFO - PROCESS | 1678 | Values: 82.0 85.0 84.0 84.0 82.0 83.0 82.0 86.0 89.0 99.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:142.00 stddev:5.04 (3.5%) stddev-sans-first:4.00 21:43:50 INFO - PROCESS | 1678 | Values: 151.0 143.0 140.0 145.0 147.0 135.0 136.0 139.0 141.0 138.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.40 Median:164.50 stddev:3.41 (2.1%) stddev-sans-first:3.57 21:43:50 INFO - PROCESS | 1678 | Values: 163.0 165.0 163.0 162.0 164.0 165.0 161.0 166.0 162.0 173.0 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:81.00 stddev:9.33 (11.5%) stddev-sans-first:9.55 21:43:50 INFO - PROCESS | 1678 | Values: 68.0 65.0 80.0 85.0 85.0 85.0 82.0 71.0 63.0 65.0 21:43:50 INFO - PROCESS | 1678 | -------- Summary: end -------- 21:43:50 INFO - PROCESS | 1678 | 21:43:50 INFO - TEST-INFO | 1678: exit 0 21:43:50 INFO - TEST-OK | kraken | took 58949ms 21:43:50 INFO - SUITE-END | took 1176s 21:43:51 INFO - Completed test suite (00:19:36) 21:43:51 INFO - javascript benchmark 21:43:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.084501762015, 3334.216459132104, 3361.9831900840477, 3389.3560223557506, 3417.2311229973243, 5554.805581804638, 5733.082706766918, 5751.10857817038, 5783.190353350535, 5797.275340582422, 5670.291213598301, 5744.109663002241, 5747.942520574793, 5754.74103665335, 5774.82675519734, 5194.572210234665, 5242.79028838846, 5253.290805741233, 5254.7635356409055, 5287.365516138049, 5166.17341225404, 5202.219667049935, 5309.522143007129, 5323.9467605324035, 5328.254044433782, 5202.973985130069, 5227.947720522784, 5251.343582052244, 5271.604629652772, 5285.524302812746, 5155.536001759822, 5176.86109056009, 5211.661242019257, 5249.580033597341, 5251.4485978972425, 5153.020926024044, 5183.481651834824, 5213.087709650834, 5219.582433405319, 5254.290670759437, 5624.381318055051, 5636.0, 5653.830385088454, 5658.519025882805, 5666.773329066832, 6158.630482171084, 6183.443490085869, 6201.5348848836065, 6202.286737025254, 6209.87580248397, 5508.228847961289, 6357.93642063578, 6372.171617689671, 6379.0, 6386.808395748135, 5729.684867332337, 5736.77052917887, 5827.65034097947, 5837.416258374129, 5875.001249787546, 6297.622142671455, 6307.96846015767, 6318.4313411793155, 6320.873582528416, 6323.146375239376, 6190.288116866528, 6216.222972128484, 6219.937800621936, 6220.191375121296, 6235.594686345373, 6147.262328520606, 6169.074638804215, 6184.257889053342, 6208.72060757267, 6285.9057114143325, 6198.349173336735, 6224.221972253468, 6251.28110267316, 6252.906206406908, 6259.561830671809, 6201.782937597162, 6218.968905155536, 6267.2792628847355, 6274.215723034621, 6277.748890044439, 4875.1224779540025, 4901.828436004723, 4951.554360107608, 4959.479254678206, 4977.676451030671, 4438.0, 4469.173202957463, 4472.127935052634, 4481.462224533077, 4547.977260113678, 5892.793752218652, 5913.9112913306335, 5919.852003699856, 5920.79277225295, 5925.259342582177, 6321.589096708699, 6337.936620633827, 6339.2709838368255, 6342.8414289642205, 6363.649999249993, 5639.830805075854, 5713.800016999385, 5715.8571035724435, 5817.0401883689565, 5817.912731309034, 5298.761555730001, 5381.219723140122, 5406.378266499324, 5421.376541697677, 5425.13197888336, 6297.811065668037, 6346.238451385679, 6354.491640668735, 6364.554481186457, 6387.744490220339, 6227.657478838526, 6292.0, 6300.432961033529, 6301.243850737941, 6307.306196318493, 5282.234076058873, 6281.528885333527, 6311.431971122621, 6342.23893132827, 6351.015592583157, 6119.6133408368505, 6141.2098563120835, 6152.323244443018, 6250.9062364065485, 6268.529860260407, 5878.970605146947, 6348.936510634834, 6356.936430635819, 6372.139761132188, 6374.649394283359, 5945.91081133792, 6160.630362178284, 6168.660723660242, 6183.258009038944, 6185.103160041859, 5980.850478738066, 6048.36492168316, 6074.149619053424, 6110.194261626952, 6112.235970503687, 6045.486133678686, 6052.90920636182, 6058.5153187745755, 6060.606060606046, 6097.085437184458, 6151.384861513991, 6166.691665416622, 6183.319834818257, 6188.257409110935, 6209.875802483834, 5803.912941305799, 5829.183914251923, 5850.765969361178, 5890.322612899571, 5972.970135149297], "value": 5727.156663518419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.3373196205054, 486.5718168012149, 521.937367515898, 534.9491798279162, 539.0431983229767, 30441.847790761043, 31457.370852582935, 40016.0, 41078.794606027004, 41267.58732412675, 43536.0, 43743.56256437435, 43744.562554374446, 43871.56128438715, 43878.12243755123, 9863.60545578176, 10065.597376104946, 10067.69796906094, 10070.949645251763, 10071.748206294864, 9963.302568820185, 10065.245106616996, 10066.446345450997, 10074.74813129674, 10079.0, 10027.548760305805, 10086.394816311045, 10097.798044039115, 10113.595456181743, 10127.088562029416, 10073.647422340257, 10084.596616135346, 10085.798284034277, 10087.596496140146, 10109.797804043914, 9898.307118501636, 9950.502474876299, 9959.601615935426, 9959.950200248952, 9980.101790838788, 40963.59036409628, 41194.38208426876, 41266.79366603178, 41294.79352603248, 41353.58646413557, 3413.385590593692, 3767.9786624124326, 4030.5163380394247, 4035.778032208227, 4123.505179378464, 30495.542566861513, 30561.23596910073, 31655.84172079125, 32732.836335818167, 32744.508832367534, 3109.4046095385615, 3178.6503484616674, 3210.2455922858107, 3219.7263232625255, 3251.5935508061493, 532071.0, 532543.0, 533164.3341783305, 533386.0, 534803.0, 64260.35739642637, 64921.67539162274, 64968.67515662486, 65086.023709644396, 65091.349086508526, 34659.96020119401, 34950.82524587412, 35234.0, 36290.45564316538, 36306.45540316898, 16245.593860153354, 16307.0, 16411.93322434038, 16419.1790410479, 16517.58706032335, 12483.063770217088, 12562.246265224116, 12566.05754568411, 12573.497060117676, 12585.307808070644, 19137.425877223704, 19308.03459827031, 19314.613707725766, 19315.710264346046, 19316.32392866243, 7844.333231675371, 7857.332126769289, 7864.764057078182, 7986.720464783704, 8052.315553177928, 721.4192574977089, 884.2174675412307, 886.6763631274538, 969.0842154164388, 1002.8094662014194, 26860.59709104365, 29345.413091738472, 29921.102366929026, 30035.64483149931, 30644.69355306463, 860.819227962135, 955.4506158958627, 996.5814357969671, 1029.1715169288645, 1070.9518071686794, 12919.741605167845, 15590.532284031497, 15646.9217653911, 15853.207339633203, 16052.598685032968, 659944.7002764955, 668978.0, 669856.0, 670167.0, 670327.0, 59332.0, 59697.0, 59799.10301345396, 59812.0, 59888.40111598915, 1110.8666959964694, 1204.9939750301369, 1251.6557946564585, 1393.303348325837, 1397.2734178227063, 27333.633318334403, 30203.697963020088, 31239.06282811519, 31282.374352513278, 32541.837290813393, 50732.492675072775, 51450.74274628603, 51455.48544514507, 51477.97044059023, 51511.2273315893, 587387.0, 594503.0, 594664.0, 594710.0, 595294.0, 27040.45919081568, 27760.722392775813, 27876.44247115087, 28665.423401713106, 28702.42595148127, 48109.75945120252, 48586.5141348582, 48854.534363969135, 48900.75549622229, 49128.50871491382, 39039.88175785358, 40147.0, 40231.59768402279, 41503.0, 41654.37518437287, 35937.74217902361, 36941.0, 39244.80377598094, 39650.0, 41158.588414115475, 37456.2508749818, 39000.41499377568, 39424.40863386994, 39512.40731388974, 39559.80220098881, 32478.675213247567, 34600.307993840484, 35113.47329790004, 35227.0, 35263.47104793379, 22486.212982545534, 24677.0, 25301.746982529938, 25656.102036428634, 25949.0], "value": 20006.14528557082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.61366053905044, 342.5307328959326, 347.6853447629896, 381.89497888080774, 408.4383972038447, 15259.23703814809, 15344.846551534481, 16451.83548164518, 20883.269085582007, 21037.26515552976, 17840.553986150353, 20452.795472045276, 20526.178952841867, 20661.380158595268, 20673.896630516825, 5782.624129431584, 6025.9096113558335, 6031.547633927473, 6031.607945483552, 6043.305019922721, 3969.186316805048, 5944.0, 5998.40015998401, 6010.8497287567725, 6024.126501657257, 5669.489745922866, 5951.49412299955, 5957.0, 5957.1659967604355, 5964.701764911759, 5778.768849246025, 5779.739911703983, 5878.1476685880525, 5880.029795083806, 5891.734871930774, 5126.5642420394315, 5139.306193663845, 5141.408737995103, 5279.392869819982, 5502.532284755801, 13246.40391182399, 13399.598012059654, 13449.26029068401, 13492.460301587924, 22009.889950550303, 2097.760378822703, 2207.260567709819, 2221.8777967211795, 2263.8302127340517, 2290.461741490765, 9734.269929755297, 9851.507424628811, 10028.749281267954, 10156.136728378096, 10391.740206494822, 1628.6986907422047, 1833.6607727570442, 1925.5763731978943, 1934.4390126863193, 2029.9086541105685, 114280.42859785732, 118208.0, 119914.0, 120088.39955800252, 126094.73905261014, 11080.778384432428, 11133.498992545356, 11295.604653837241, 11752.059835213162, 11904.821427678591, 14607.269636518131, 14613.342399592044, 14626.902982276159, 14634.195119268543, 14644.414223431157, 7704.922950770532, 8045.436819422701, 8415.0, 8533.359998000175, 8584.699535516227, 6996.860062798715, 8146.7148649798155, 8210.753677389688, 8291.709790157316, 8502.659893604186, 4112.403701463331, 4511.548845115528, 4567.611753000966, 4600.976995115003, 4628.213203755302, 1851.759271294723, 1888.2824526679774, 1898.7626546681665, 1900.116445852685, 1901.1919934027983, 815.1807433529265, 840.8990921089509, 853.1553761775797, 908.8732366262976, 995.049727510226, 20751.377458676263, 21169.894150529148, 21253.89373053125, 21282.574348512942, 21338.57322853534, 895.9955200224088, 898.5641963647626, 903.8282726281985, 907.4782000349825, 915.6291701860757, 10552.472376381304, 11143.275687080313, 11170.329780213213, 11192.328460292245, 11216.102711783202, 533089.0, 535197.0, 536362.0, 608324.0, 647979.0, 84632.76836158168, 143778.2811085938, 146579.80130298054, 149625.0, 150939.0, 945.9810803783886, 960.3805545423163, 1004.2719028704277, 1005.607812952949, 1007.1791489935825, 18296.268149274412, 18708.625827483647, 19047.809521904604, 19110.426687199408, 19403.0, 35758.0, 53033.46966530285, 53281.4671853292, 55808.0, 57058.0, 79538.0, 79774.20225797668, 80732.59633701794, 81602.77595835949, 81964.0, 7938.126806051214, 8043.19568043191, 8145.633446494803, 8174.427790054877, 8189.79525511867, 12156.878431215575, 12549.749005019667, 12770.489180432678, 12983.285919274153, 13019.609411717664, 10838.187135964992, 10886.183536234972, 10901.945490272497, 11177.441127943734, 11230.0, 9886.653967111117, 9892.356996795184, 10361.44578313259, 10568.207384446043, 10702.678919632424, 11098.5560577576, 11137.665870023913, 11509.0, 11570.421478926188, 11610.187286889837, 7888.566128862968, 7974.92025079765, 7984.600769961363, 8104.108548059827, 8148.981377327834, 10731.356118632906, 11071.114310855273, 11103.38931358783, 11139.610113645984, 11548.653540393801], "value": 9295.372199855756, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.7548841208584, 1543.4212170436083, 1737.9478615641526, 1870.1210431097397, 1933.8839669619824, 8437.746867593974, 8980.146886045823, 8982.730518084469, 8982.955085224581, 9008.0541543138, 7763.0, 8064.9596752016305, 8065.959670201641, 8160.877586836202, 8166.754997350089, 2156.1914282144235, 2305.0664480885184, 2367.159658321297, 2374.7150341958904, 2390.282915125464, 2393.5212957408503, 2394.3295877154337, 2420.7942324902406, 2422.63660450932, 2424.7211570669333, 2418.5283869645427, 2422.4549476367765, 2425.721042080157, 2426.5268272686835, 2426.708794944609, 2366.692329997098, 2409.1688367513266, 2412.4560281419904, 2412.6381042843714, 2415.9396015099587, 2390.3665528634924, 2395.377201927494, 2405.2183040511727, 2412.867292298923, 2414.5050264695697, 8765.386422950396, 8944.597493112826, 8952.597133129026, 8956.955215223883, 8967.730968070968, 4924.433690125646, 5018.222175562793, 5217.113090774577, 5354.544863686591, 5371.543418809367, 3171.4925611901986, 3572.517710109128, 3661.505696730934, 3710.684591809699, 3723.7765734055774, 1064.6539874540729, 1099.8185299425586, 1121.344013751956, 1124.3254047571393, 1128.9491972861158, 9745.512724363824, 11205.0, 11504.42477876103, 11540.365279909602, 11724.531018759239, 4158.9584104158575, 4473.977630111894, 4527.845399423126, 4559.658025648023, 4666.976665116721, 7877.645505952246, 7890.132085470594, 9146.496942668216, 9161.221296189899, 9220.8616870747, 5203.505666961632, 5206.349206349207, 5208.192730126836, 5213.348331458567, 5218.869528261824, 4653.790579423934, 4795.160846851787, 4847.733374664427, 4849.102915960559, 4864.975675121602, 3686.4838922550866, 3714.5728241252064, 3741.2704522618374, 3764.8305826237884, 3824.4263360496147, 1146.295028557448, 1157.114807172497, 1158.6060739348661, 1162.1632424654235, 1169.9883001169878, 762.1083332500987, 860.8020155364176, 901.8511945528915, 915.7573243090586, 920.3925409229876, 5780.306363236438, 5821.76712931478, 5874.471297583153, 5946.286445626552, 6107.816765497042, 785.3560080733744, 930.7905721212672, 957.6313119448923, 965.75856035991, 1000.3747657713928, 3965.6629186518894, 4037.878863634037, 4053.858114965962, 4148.460700108966, 4161.292580261363, 10386.221033422524, 10850.457477126112, 10855.294405863593, 10869.34783912952, 10881.12950963921, 10078.395296282246, 10321.793564128826, 10782.137429005661, 10808.135349172047, 10808.94595527033, 8049.597520123971, 8242.29940455068, 8259.876101858477, 8262.958685206535, 8271.8345633087, 5926.407359264039, 6033.456988871023, 6044.486218671462, 6163.506919446523, 6170.50635949114, 9656.0, 9730.416175029237, 9787.951060244653, 9969.451680157661, 10004.599816007569, 10161.644342447978, 10329.74175645615, 10345.534450949875, 10347.63783267582, 10361.533730981973, 5882.058870580687, 6963.442924566124, 7176.820579485555, 7182.3535881770895, 7186.173590037003, 8152.877706834283, 8549.145085491402, 8553.914460855312, 8565.400421970402, 8569.571521424028, 7376.7786966391095, 7555.508891922007, 7606.315431611181, 7667.616619169131, 7763.883541746765, 7349.522281051714, 7471.066116735408, 7493.40052795786, 7512.098548174254, 7563.924360756322, 7045.506814522934, 7164.641767911479, 7169.4981351307, 7173.784786456415, 7179.712811487482, 4853.975730121327, 4955.281484184845, 4975.6019518437715, 5028.899422011613, 5196.766145523537, 4835.564799168092, 4933.210686290176, 4948.480409556944, 4996.050750357421, 5160.535551800206], "value": 4561.532050915768, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.7028227196211, 302.3227969348659, 309.76457892002077, 314.36027683663735, 315.5109580150766, 4104.425380446736, 4274.252005898971, 5312.335958005249, 5324.62727609067, 5389.846939540369, 5051.9539586467445, 5059.822906198275, 5219.191025391061, 5236.1098613235745, 5379.6503227290195, 4066.6543343815665, 4077.8368865245357, 4077.979610101953, 4109.260333140033, 4111.527174374955, 4072.75563466193, 4081.2245673321972, 4093.897652558695, 4118.0, 4178.6657067434535, 3788.734788564788, 3911.3546264866263, 4014.6988975826785, 4065.0, 4081.3469844824835, 4017.8392864285393, 4028.2950483665536, 4064.2726841092417, 4067.877963661095, 4073.775942323171, 3464.2725027744204, 3470.6008808986785, 3475.4265546184847, 3482.1294676330917, 3505.4216054351, 4848.5151484851585, 4978.8257410990445, 5228.424873263938, 5277.419483856773, 5299.5230429261555, 4570.349197465495, 4580.748058856761, 4588.7246765194195, 4598.574441923015, 4626.699264547794, 4951.628627852925, 5583.4137415571595, 5585.553155747531, 5590.916136257919, 5592.552595792326, 3786.8828695534885, 3832.2335532893535, 3837.4435706822633, 3842.50047493824, 3848.5958974307573, 3641.362761516724, 4916.483769204254, 4943.777530011158, 5903.498202652822, 5929.792457263975, 3603.279344131184, 3839.310703290543, 3862.980685096613, 3874.3219936511, 3885.0, 3652.8448215552953, 3937.7161246476976, 3942.541259733917, 3961.623645753649, 3968.8809335719975, 4333.414988976448, 4575.382323386367, 4618.445786505641, 4638.3070179384285, 4673.392458980311, 5648.576356773258, 5651.208830763697, 5657.377688454267, 5660.518855897212, 5670.0, 1098.083100610983, 1121.5401685308984, 1303.843538775334, 1308.8560258371572, 1348.2112963916022, 713.8429545500086, 921.5346250143634, 939.145377706284, 953.5041778275258, 959.2661613865398, 4618.2841659542155, 5075.695458272516, 5299.629025968223, 5308.548773354231, 5361.92761447712, 5678.914816277676, 5696.202531645573, 5728.255326807572, 5768.538516918637, 5793.246877905845, 4982.501749824988, 5273.551748101378, 5284.39229488606, 5293.973530132324, 5305.6551324164575, 2439.4023464251372, 3038.2708150044273, 3040.9847950760104, 3060.515649909792, 3062.6784187659973, 4924.729139897268, 5001.624878134155, 5179.056837410818, 5983.042713165873, 6047.365026672224, 5160.716160611128, 5722.027255366597, 5784.248047753765, 5801.564882633819, 5809.157672137517, 4978.60171186297, 5832.037713777264, 5852.678102704393, 5879.559033072536, 5906.320773111147, 4629.231891152119, 5035.874103147451, 5221.295125158207, 5586.597762961803, 5764.654120752768, 4741.407324084489, 5620.241267429008, 5625.803096891589, 5629.228416960728, 5670.914936276042, 5133.076046311699, 5584.743432727604, 5894.440028197314, 5946.524278057658, 6043.637381757108, 3457.9135521611156, 3728.7135938102397, 3937.370020796773, 3956.663683586927, 4000.3999400089056, 5147.871303217449, 5185.248139019896, 5196.68819870809, 5660.0, 5811.53507719373, 4905.688073394495, 4995.650304478651, 5629.6903670298525, 5630.63400878958, 5707.4577915098, 4684.016356565159, 4837.250226214942, 5389.2455056291365, 5521.447855214607, 5567.220589117445, 4958.305837182726, 5158.793648254028, 5171.5609119934825, 5434.891302174014, 5444.292242008672, 5227.764750586157, 5392.570968693378, 5393.921215756786, 5524.66851988882, 5701.458361455655, 4857.587105096107, 5443.972780136074, 5594.916076258941, 5668.773249069991, 5706.714664266853], "value": 4072.854909473051, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.8565294114704, 714.2607401339613, 762.0931092000519, 783.2559068884558, 822.8107535266885, 15585.220738963064, 16562.917185414088, 16585.91707041466, 16600.920940138883, 16660.416885409013, 14717.264136793172, 14776.113433194016, 14782.630434239149, 14794.038387504805, 14845.0, 689.3175756001573, 705.0869124483805, 853.1255463150259, 853.624405261686, 875.9956200219021, 862.7153039496951, 865.9263962563158, 874.9475031498099, 875.6978842299396, 877.4165180155189, 906.4833045164258, 931.0921851195098, 931.78568929146, 932.9877083364557, 934.2946075712862, 723.2550473012806, 741.3290971670647, 923.1968187676697, 923.8937522184934, 924.2836801478841, 666.9599824010575, 677.7864972533686, 681.3527149208222, 691.6265216782931, 694.506900100929, 12477.812832807514, 15206.847931520653, 15426.922865385714, 15471.22643867802, 15493.302801373853, 13916.860831391657, 14216.573502794932, 14371.640708982255, 14442.494512692005, 14452.710945781026, 12475.937620311932, 12581.0, 12768.233905965672, 13149.605511834565, 13379.732405351935, 4623.884402889921, 4628.930566041512, 4728.8507561990355, 4778.331033655291, 4809.903801923977, 117603.0, 119305.80694193034, 120453.5909281827, 120901.39549302285, 121848.78151218464, 9592.904070959341, 11122.777544449065, 11292.604758833566, 11396.829047564293, 11403.657890263305, 22532.436689082904, 22579.548409031726, 22651.320460386214, 22753.0, 22762.975666094735, 7841.372690184771, 8067.031956165298, 8067.314278286294, 8235.21765432283, 8262.669493220204, 4195.559466256061, 4271.444712187395, 4294.398784170218, 4359.06280149763, 4383.846565370197, 3528.4883691864534, 3604.2971620533744, 3606.945895811565, 3608.6030536640947, 3614.8373323200517, 560.7700842654492, 634.996825015872, 640.5580149696694, 641.6118248459708, 642.0722056628221, 557.8633234857405, 627.6547898655721, 628.1802248066226, 638.5434414393638, 641.5541198866836, 8556.868287730524, 8911.55442227886, 9077.636894524278, 9240.168384845396, 9269.119433653792, 563.5284021291069, 612.4120843989731, 617.6325086573481, 631.3339426904568, 654.2900952466532, 4264.850730224489, 4480.641548676098, 4491.505934347219, 4514.300283456069, 4539.909201816011, 110427.34358984622, 120694.15487993252, 160809.19595402182, 161601.19199403928, 166516.0, 38144.809275953994, 38537.614623853406, 38625.61374386276, 38634.0, 66345.0, 77531.61234193793, 88211.55894220488, 108919.91080089098, 126751.73248267584, 129634.35182824025, 7688.577128258, 7981.002374703162, 8136.180897012383, 8690.565471726515, 8703.390762646553, 64162.0, 66175.66912165408, 66279.0174442161, 66765.66617167077, 66944.3305566938, 80299.0, 96234.37656234321, 102724.97275027154, 105274.42088368833, 109447.0, 11601.553371024043, 11711.531538738354, 11744.70638234051, 11756.647300580997, 12112.576059837864, 11638.825417618573, 11873.397091392551, 12100.636980890587, 12714.046446516364, 12901.161424507753, 11419.31484110956, 11596.785916979627, 12016.63950081499, 12148.939255303667, 12198.51205951752, 11615.245009074382, 11652.94173529127, 11690.649280521598, 11884.821727674265, 12452.688682783002, 11398.601048963577, 11692.532298708296, 11801.586944456903, 11886.34625095628, 12555.93722031384, 9560.187384072431, 9637.566309515949, 9652.420854748456, 9665.71002869915, 10002.849957250794, 9590.436528148148, 9822.607095716092, 9841.507924603598, 9886.802263954825, 9899.851502227617], "value": 7459.684897322846, "unit": "score"}], "name": "dromaeo_css", "value": 7269.82932282661, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 121.0, 167.0, 162.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 110.0, 143.0, 111.0, 110.0, 107.0, 109.0, 140.0, 116.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 185.0, 185.0, 182.0, 184.0, 182.0, 182.0, 186.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 89.0, 63.0, 72.0, 81.0, 82.0, 83.0, 57.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 94.0, 70.0, 68.0, 69.0, 92.0, 68.0, 69.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 87.0, 84.0, 89.0, 84.0, 86.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 99.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 52.0, 53.0, 57.0, 79.0, 87.0, 88.0, 85.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 80.0, 78.0, 74.0, 69.0, 70.0, 72.0, 70.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 84.0, 84.0, 82.0, 83.0, 82.0, 86.0, 89.0, 99.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 143.0, 140.0, 145.0, 147.0, 135.0, 136.0, 139.0, 141.0, 138.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 162.0, 164.0, 165.0, 161.0, 166.0, 162.0, 173.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 80.0, 85.0, 85.0, 85.0, 82.0, 71.0, 63.0, 65.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1450.4, "alertThreshold": 2.0}]} 21:43:51 INFO - Return code: 0 21:43:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:43:51 INFO - # TBPL SUCCESS # 21:43:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:43:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:43:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:43:51 INFO - 2016-11-12 21:43:51.481 screenresolution[1682:15788] starting screenresolution argv=screenresolution get 21:43:51 INFO - 2016-11-12 21:43:51.484 screenresolution[1682:15788] Display 0: 1600x1200x32@60 21:43:51 INFO - 2016-11-12 21:43:51.489 screenresolution[1683:15791] starting screenresolution argv=screenresolution list 21:43:51 INFO - Available Modes on Display 0 21:43:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:43:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:43:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:43:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:43:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:43:51 INFO - Intel Iris: 21:43:51 INFO - Chipset Model: Intel Iris 21:43:51 INFO - Type: GPU 21:43:51 INFO - Bus: Built-In 21:43:51 INFO - VRAM (Dynamic, Max): 1536 MB 21:43:51 INFO - Vendor: Intel (0x8086) 21:43:51 INFO - Device ID: 0x0a2e 21:43:51 INFO - Revision ID: 0x0009 21:43:51 INFO - Displays: 21:43:51 INFO - Display: 21:43:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:43:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:43:51 INFO - Display Serial Number: 1600x1200 60 21:43:51 INFO - Main Display: Yes 21:43:51 INFO - Mirror: Off 21:43:51 INFO - Online: Yes 21:43:51 INFO - Rotation: Supported 21:43:51 INFO - Return code: 0 21:43:51 INFO - Running post-action listener: _resource_record_post_action 21:43:51 INFO - [mozharness: 2016-11-13 05:43:51.728648Z] Finished run-tests step (success) 21:43:51 INFO - Running post-run listener: _resource_record_post_run 21:43:51 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32050176; Write bytes: 663326720; Read time: 195; Write time: 1885 21:43:51 INFO - TinderboxPrint: CPU usage
53.4% 21:43:51 INFO - TinderboxPrint: I/O read bytes / time
32,050,176 / 195 21:43:51 INFO - TinderboxPrint: I/O write bytes / time
663,326,720 / 1,885 21:43:51 INFO - TinderboxPrint: CPU idle
2,255.3 (46.6%) 21:43:51 INFO - TinderboxPrint: CPU system
964.4 (19.9%) 21:43:51 INFO - TinderboxPrint: CPU user
1,618.0 (33.4%) 21:43:51 INFO - TinderboxPrint: Swap in / out
391,389,184 / 0 21:43:51 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358851072; Write bytes: 356246528; Read time: 27860; Write time: 756 21:43:51 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30182400; Write bytes: 296082432; Read time: 180; Write time: 1097 21:43:52 INFO - Running post-run listener: _upload_blobber_files 21:43:52 INFO - Blob upload gear active. 21:43:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:43:52 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 21:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:43:52 INFO - (blobuploader) - INFO - Open directory for files ... 21:43:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:43:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:53 INFO - (blobuploader) - INFO - Done attempting. 21:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:43:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:54 INFO - (blobuploader) - INFO - Done attempting. 21:43:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:43:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:43:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:43:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:43:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:43:56 INFO - (blobuploader) - INFO - Done attempting. 21:43:56 INFO - (blobuploader) - INFO - Iteration through files over. 21:43:56 INFO - Return code: 0 21:43:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:43:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:43:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d731d05c88c8c46692138fbe5c1ad55a5aa7358cd75f2d2201ee5a52d2707cadd457a9123f04e834a3face9952fff1a700ec4c47d3daa3e12229b1dc1d15e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e828eabe76cedaa8371a7549c81cd50a1611edebd2ac9b308b7afb1709560ca6b3a3cc994a0d1e1318d470f38594326f12edfaafdc3c154538eda9581f53d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0af9f7f2eec6597e9b3de6b761033838fc21e4e1cb58b6c55f91d74e6e8864eabb202dbd1a87ef32fbc78cadad3d22022fe3034e84adef1ff04655997331c69"} 21:43:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:43:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:43:56 INFO - Contents: 21:43:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d731d05c88c8c46692138fbe5c1ad55a5aa7358cd75f2d2201ee5a52d2707cadd457a9123f04e834a3face9952fff1a700ec4c47d3daa3e12229b1dc1d15e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e828eabe76cedaa8371a7549c81cd50a1611edebd2ac9b308b7afb1709560ca6b3a3cc994a0d1e1318d470f38594326f12edfaafdc3c154538eda9581f53d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0af9f7f2eec6597e9b3de6b761033838fc21e4e1cb58b6c55f91d74e6e8864eabb202dbd1a87ef32fbc78cadad3d22022fe3034e84adef1ff04655997331c69"} 21:43:56 INFO - Running post-run listener: copy_logs_to_upload_dir 21:43:56 INFO - Copying logs to upload dir... 21:43:56 INFO - mkdir: /builds/slave/test/build/upload/logs 21:43:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.556066 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-12 21:43:56.833863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 21:43:56.838235) ========= 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.7IbgusGkmO/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.vupUXbCjQD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d731d05c88c8c46692138fbe5c1ad55a5aa7358cd75f2d2201ee5a52d2707cadd457a9123f04e834a3face9952fff1a700ec4c47d3daa3e12229b1dc1d15e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e828eabe76cedaa8371a7549c81cd50a1611edebd2ac9b308b7afb1709560ca6b3a3cc994a0d1e1318d470f38594326f12edfaafdc3c154538eda9581f53d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0af9f7f2eec6597e9b3de6b761033838fc21e4e1cb58b6c55f91d74e6e8864eabb202dbd1a87ef32fbc78cadad3d22022fe3034e84adef1ff04655997331c69"} build_url:https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/Qe7kaGi0QkicsrDuHx3DHQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d731d05c88c8c46692138fbe5c1ad55a5aa7358cd75f2d2201ee5a52d2707cadd457a9123f04e834a3face9952fff1a700ec4c47d3daa3e12229b1dc1d15e94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e828eabe76cedaa8371a7549c81cd50a1611edebd2ac9b308b7afb1709560ca6b3a3cc994a0d1e1318d470f38594326f12edfaafdc3c154538eda9581f53d5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0af9f7f2eec6597e9b3de6b761033838fc21e4e1cb58b6c55f91d74e6e8864eabb202dbd1a87ef32fbc78cadad3d22022fe3034e84adef1ff04655997331c69"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 21:43:56.872097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:43:56.872432) ========= 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.7IbgusGkmO/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.vupUXbCjQD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:43:56.922157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 21:43:56.922477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 21:43:56.922894) ========= ========= Total master_lag: 0.19 =========