builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0326 starttime: 1475523893.13 results: success (0) buildid: 20161003103758 builduid: 6183b50226804d739c1f6e0a8019ce1c revision: ba4c1706898b4b7edcca633e2844e6ee12556cb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.131739) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.132200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.132505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.221248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.221540) ========= 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.JzLPKSNv75/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.AcmjpixyUz/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-03 12:44:53-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-10-03 12:44:53 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165689 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.426939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.427218) ========= 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.JzLPKSNv75/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.AcmjpixyUz/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.034560 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.489092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:53.489445) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ba4c1706898b4b7edcca633e2844e6ee12556cb9 --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 ba4c1706898b4b7edcca633e2844e6ee12556cb9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JzLPKSNv75/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.AcmjpixyUz/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-03 12:44:53,563 truncating revision to first 12 chars 2016-10-03 12:44:53,564 Setting DEBUG logging. 2016-10-03 12:44:53,564 attempt 1/10 2016-10-03 12:44:53,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ba4c1706898b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 12:44:54,201 unpacking tar archive at: mozilla-aurora-ba4c1706898b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.908934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:54.422688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:54.424782) ========= script_repo_revision: ba4c1706898b4b7edcca633e2844e6ee12556cb9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:54.425270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:54.425530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:44:54.444732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-03 12:44:54.445030) ========= /tools/buildbot/bin/python 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', '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.JzLPKSNv75/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.AcmjpixyUz/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:44:54 INFO - MultiFileLogger online at 20161003 12:44:54 in /builds/slave/test 12:44:54 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 12:44:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:44:54 INFO - {'append_to_log': False, 12:44:54 INFO - 'base_work_dir': '/builds/slave/test', 12:44:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:44:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:44:54 INFO - 'branch': 'Mozilla-Aurora', 12:44:54 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:54 INFO - 'config_files': ('talos/mac_config.py',), 12:44:54 INFO - 'default_actions': ('clobber', 12:44:54 INFO - 'read-buildbot-config', 12:44:54 INFO - 'download-and-extract', 12:44:54 INFO - 'populate-webroot', 12:44:54 INFO - 'create-virtualenv', 12:44:54 INFO - 'install', 12:44:54 INFO - 'run-tests'), 12:44:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:54 INFO - 'download_minidump_stackwalk': True, 12:44:54 INFO - 'download_symbols': 'ondemand', 12:44:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:54 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:54 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:54 INFO - 'installer_path': 'installer.exe', 12:44:54 INFO - 'log_level': 'info', 12:44:54 INFO - 'log_name': 'talos', 12:44:54 INFO - 'log_to_console': True, 12:44:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:44:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:44:54 INFO - 'opt_config_files': (), 12:44:54 INFO - 'pip_index': False, 12:44:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:44:54 INFO - 'cmd': ('bash', 12:44:54 INFO - '-c', 12:44:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:44:54 INFO - 'enabled': True, 12:44:54 INFO - 'halt_on_failure': False, 12:44:54 INFO - 'name': 'check_screen_resolution'},), 12:44:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:44:54 INFO - 'cmd': ('bash', 12:44:54 INFO - '-c', 12:44:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:44:54 INFO - 'enabled': True, 12:44:54 INFO - 'halt_on_failure': False, 12:44:54 INFO - 'name': 'check_screen_resolution'},), 12:44:54 INFO - 'run_cmd_checks_enabled': True, 12:44:54 INFO - 'sps_profile': False, 12:44:54 INFO - 'sps_profile_interval': 0, 12:44:54 INFO - 'suite': 'dromaeojs', 12:44:54 INFO - 'system_bits': '32', 12:44:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:54 INFO - 'title': 't-yosemite-r7-0326', 12:44:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:54 INFO - 'use_talos_json': True, 12:44:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:44:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:54 INFO - 'work_dir': 'build'} 12:44:54 INFO - [mozharness: 2016-10-03 19:44:54.640661Z] Running clobber step. 12:44:54 INFO - Running pre-action listener: _resource_record_pre_action 12:44:54 INFO - Running main action method: clobber 12:44:54 INFO - rmtree: /builds/slave/test/build 12:44:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:44:56 INFO - Running post-action listener: _resource_record_post_action 12:44:56 INFO - [mozharness: 2016-10-03 19:44:56.985079Z] Finished clobber step (success) 12:44:56 INFO - [mozharness: 2016-10-03 19:44:56.985384Z] Running read-buildbot-config step. 12:44:56 INFO - Running pre-action listener: _resource_record_pre_action 12:44:56 INFO - Running main action method: read_buildbot_config 12:44:56 INFO - Using buildbot properties: 12:44:56 INFO - { 12:44:56 INFO - "project": "", 12:44:56 INFO - "product": "firefox", 12:44:56 INFO - "script_repo_revision": "production", 12:44:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:44:56 INFO - "repository": "", 12:44:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:44:56 INFO - "buildid": "20161003103758", 12:44:56 INFO - "pgo_build": "False", 12:44:56 INFO - "basedir": "/builds/slave/test", 12:44:56 INFO - "buildnumber": 80, 12:44:56 INFO - "slavename": "t-yosemite-r7-0326", 12:44:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:44:56 INFO - "platform": "yosemite_r7", 12:44:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:44:56 INFO - "branch": "mozilla-aurora", 12:44:56 INFO - "repo_path": "releases/mozilla-aurora", 12:44:56 INFO - "revision": "ba4c1706898b4b7edcca633e2844e6ee12556cb9", 12:44:56 INFO - "stage_platform": "macosx64", 12:44:56 INFO - "builduid": "6183b50226804d739c1f6e0a8019ce1c", 12:44:56 INFO - "slavebuilddir": "test" 12:44:56 INFO - } 12:44:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:44:56 INFO - Running post-action listener: _resource_record_post_action 12:44:56 INFO - [mozharness: 2016-10-03 19:44:56.991435Z] Finished read-buildbot-config step (success) 12:44:56 INFO - [mozharness: 2016-10-03 19:44:56.991612Z] Running download-and-extract step. 12:44:56 INFO - Running pre-action listener: _resource_record_pre_action 12:44:56 INFO - Running main action method: download_and_extract 12:44:56 INFO - mkdir: /builds/slave/test/build/tests 12:44:56 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')]} 12:44:56 INFO - trying https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:44:56 INFO - Downloading https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/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 12:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/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 12:44:58 INFO - Downloaded 1199 bytes. 12:44:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:44:58 INFO - Using the following test package requirements: 12:44:58 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:44:58 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:44:58 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:44:58 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'jsshell-mac.zip'], 12:44:58 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:44:58 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:44:58 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:44:58 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:44:58 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:44:58 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:44:58 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:44:58 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:44:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:44:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:44:58 INFO - Fetch https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:44:58 INFO - Expected file size: 16434146 12:45:05 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 12:45:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:45:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:45:05 INFO - Fetch https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:45:06 INFO - Expected file size: 16434146 12:45:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:45:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:45:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:45:13 INFO - Expected file size: 14414059 12:45: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')]} 12:45:14 INFO - trying https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:45:14 INFO - Downloading https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/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 12:45:17 INFO - Downloaded 115277438 bytes. 12:45:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:45:17 INFO - mkdir: /builds/slave/test/properties 12:45:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:17 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:17 INFO - Contents: 12:45:17 INFO - build_url:https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:45:17 INFO - Running post-action listener: _resource_record_post_action 12:45:17 INFO - Running post-action listener: set_extra_try_arguments 12:45:17 INFO - [mozharness: 2016-10-03 19:45:17.642760Z] Finished download-and-extract step (success) 12:45:17 INFO - [mozharness: 2016-10-03 19:45:17.642866Z] Running populate-webroot step. 12:45:17 INFO - Running pre-action listener: _resource_record_pre_action 12:45:17 INFO - Running main action method: populate_webroot 12:45:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:17 INFO - '--tppagecycles', 12:45:17 INFO - '7'], 12:45:17 INFO - 'tests': ['tsvgm']}}, 12:45:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:45:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:45:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:45:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['damp', 'tps']}, 12:45:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'tests': ['damp', 'tps']}, 12:45:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['dromaeo_dom']}, 12:45:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['basic_compositor_video']}, 12:45:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:45:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['a11yr', 12:45:17 INFO - 'ts_paint', 12:45:17 INFO - 'tpaint', 12:45:17 INFO - 'sessionrestore', 12:45:17 INFO - 'sessionrestore_no_auto_restore', 12:45:17 INFO - 'tabpaint']}, 12:45:17 INFO - 'other-e10s': {'tests': ['a11yr', 12:45:17 INFO - 'ts_paint', 12:45:17 INFO - 'tpaint', 12:45:17 INFO - 'sessionrestore', 12:45:17 INFO - 'sessionrestore_no_auto_restore', 12:45:17 INFO - 'tabpaint']}, 12:45:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:45:17 INFO - 'ts_paint', 12:45:17 INFO - 'tpaint', 12:45:17 INFO - 'sessionrestore', 12:45:17 INFO - 'sessionrestore_no_auto_restore', 12:45:17 INFO - 'tabpaint']}, 12:45:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:45:17 INFO - 'ts_paint', 12:45:17 INFO - 'tpaint', 12:45:17 INFO - 'sessionrestore', 12:45:17 INFO - 'sessionrestore_no_auto_restore', 12:45:17 INFO - 'tabpaint']}, 12:45:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['a11yr', 12:45:17 INFO - 'ts_paint', 12:45:17 INFO - 'tpaint', 12:45:17 INFO - 'sessionrestore', 12:45:17 INFO - 'sessionrestore_no_auto_restore', 12:45:17 INFO - 'tabpaint']}, 12:45:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['a11yr', 12:45:17 INFO - 'ts_paint', 12:45:17 INFO - 'tpaint', 12:45:17 INFO - 'sessionrestore', 12:45:17 INFO - 'sessionrestore_no_auto_restore', 12:45:17 INFO - 'tabpaint']}, 12:45:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['tsvgx', 12:45:17 INFO - 'tsvgr_opacity', 12:45:17 INFO - 'tart', 12:45:17 INFO - 'tscrollx', 12:45:17 INFO - 'cart']}, 12:45:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:45:17 INFO - 'tsvgr_opacity', 12:45:17 INFO - 'tart', 12:45:17 INFO - 'tscrollx', 12:45:17 INFO - 'cart']}, 12:45:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'talos_options': ['--disable-e10s'], 12:45:17 INFO - 'tests': ['tp5o']}, 12:45:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'tests': ['tp5o']}, 12:45:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'talos_options': ['--disable-e10s', 12:45:17 INFO - '--xperf_path', 12:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:17 INFO - 'tests': ['tp5n']}, 12:45:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:17 INFO - 'talos_options': ['--xperf_path', 12:45:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:17 INFO - 'tests': ['tp5n']}}, 12:45:17 INFO - 'talos.zip': {'path': '', 12:45:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:17 INFO - Running post-action listener: _resource_record_post_action 12:45:17 INFO - [mozharness: 2016-10-03 19:45:17.662068Z] Finished populate-webroot step (success) 12:45:17 INFO - [mozharness: 2016-10-03 19:45:17.662181Z] Running create-virtualenv step. 12:45:17 INFO - Running pre-action listener: _resource_record_pre_action 12:45:17 INFO - Running main action method: create_virtualenv 12:45:17 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45:17 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 12:45:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:17 INFO - Using real prefix '/tools/python27' 12:45:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:18 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:21 INFO - Installing pip.................done. 12:45:21 INFO - Return code: 0 12:45:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45:21 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')]} 12:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:21 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')]} 12:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:21 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:21 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 12:45:21 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 12:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:21 INFO - 'HOME': '/Users/cltbld', 12:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:21 INFO - 'LOGNAME': 'cltbld', 12:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:21 INFO - 'MOZ_NO_REMOTE': '1', 12:45:21 INFO - 'NO_EM_RESTART': '1', 12:45:21 INFO - 'PAGER': '/bin/cat', 12:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:21 INFO - 'PWD': '/builds/slave/test', 12:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:21 INFO - 'SHELL': '/bin/bash', 12:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:21 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:21 INFO - 'USER': 'cltbld', 12:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:21 INFO - 'XPC_FLAGS': '0x0', 12:45:21 INFO - 'XPC_SERVICE_NAME': '0', 12:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:21 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 12:45:21 INFO - Cleaning up... 12:45:21 INFO - Return code: 0 12:45:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:45:21 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')]} 12:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:21 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')]} 12:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:21 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:21 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 12:45:21 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 12:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:21 INFO - 'HOME': '/Users/cltbld', 12:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:21 INFO - 'LOGNAME': 'cltbld', 12:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:21 INFO - 'MOZ_NO_REMOTE': '1', 12:45:21 INFO - 'NO_EM_RESTART': '1', 12:45:21 INFO - 'PAGER': '/bin/cat', 12:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:21 INFO - 'PWD': '/builds/slave/test', 12:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:21 INFO - 'SHELL': '/bin/bash', 12:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:21 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:21 INFO - 'USER': 'cltbld', 12:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:21 INFO - 'XPC_FLAGS': '0x0', 12:45:21 INFO - 'XPC_SERVICE_NAME': '0', 12:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:21 INFO - Downloading/unpacking psutil>=3.1.1 12:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:45:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:24 INFO - Installing collected packages: psutil 12:45:24 INFO - Running setup.py install for psutil 12:45:25 INFO - building 'psutil._psutil_osx' extension 12:45:25 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 12:45:25 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 12:45:25 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 12:45:25 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 12:45:25 INFO - building 'psutil._psutil_posix' extension 12:45:25 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 12:45:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:45:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:45:25 INFO - ^ 12:45:25 INFO - 1 warning generated. 12:45:25 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 12:45:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:26 INFO - Successfully installed psutil 12:45:26 INFO - Cleaning up... 12:45:26 INFO - Return code: 0 12:45:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:45:26 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')]} 12:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:26 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')]} 12:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:26 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:26 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 12:45:26 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 12:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:26 INFO - 'HOME': '/Users/cltbld', 12:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:26 INFO - 'LOGNAME': 'cltbld', 12:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:26 INFO - 'MOZ_NO_REMOTE': '1', 12:45:26 INFO - 'NO_EM_RESTART': '1', 12:45:26 INFO - 'PAGER': '/bin/cat', 12:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:26 INFO - 'PWD': '/builds/slave/test', 12:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:26 INFO - 'SHELL': '/bin/bash', 12:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:26 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:26 INFO - 'USER': 'cltbld', 12:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:26 INFO - 'XPC_FLAGS': '0x0', 12:45:26 INFO - 'XPC_SERVICE_NAME': '0', 12:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:45:28 INFO - Installing collected packages: mozsystemmonitor 12:45:28 INFO - Running setup.py install for mozsystemmonitor 12:45:29 INFO - Successfully installed mozsystemmonitor 12:45:29 INFO - Cleaning up... 12:45:29 INFO - Return code: 0 12:45:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:45:29 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')]} 12:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:29 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')]} 12:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:29 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:29 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 12:45:29 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 12:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:29 INFO - 'HOME': '/Users/cltbld', 12:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:29 INFO - 'LOGNAME': 'cltbld', 12:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:29 INFO - 'MOZ_NO_REMOTE': '1', 12:45:29 INFO - 'NO_EM_RESTART': '1', 12:45:29 INFO - 'PAGER': '/bin/cat', 12:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:29 INFO - 'PWD': '/builds/slave/test', 12:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:29 INFO - 'SHELL': '/bin/bash', 12:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:29 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:29 INFO - 'USER': 'cltbld', 12:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:29 INFO - 'XPC_FLAGS': '0x0', 12:45:29 INFO - 'XPC_SERVICE_NAME': '0', 12:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:29 INFO - Downloading/unpacking jsonschema==2.5.1 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:45:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:45:31 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 12:45:31 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 12:45:31 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 12:45:31 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 12:45:31 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 12:45:31 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 12:45:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:45:32 INFO - warning: no files found matching '*.txt' 12:45:32 INFO - no previously-included directories found matching 'build' 12:45:32 INFO - no previously-included directories found matching 'dist' 12:45:32 INFO - no previously-included directories found matching '.git*' 12:45:32 INFO - Installing collected packages: jsonschema, functools32 12:45:32 INFO - Running setup.py install for functools32 12:45:32 INFO - warning: no files found matching '*.txt' 12:45:32 INFO - no previously-included directories found matching 'build' 12:45:32 INFO - no previously-included directories found matching 'dist' 12:45:32 INFO - no previously-included directories found matching '.git*' 12:45:32 INFO - Successfully installed jsonschema functools32 12:45:32 INFO - Cleaning up... 12:45:32 INFO - Return code: 0 12:45:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:45:32 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')]} 12:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:32 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')]} 12:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:32 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:32 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 12:45:32 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 12:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:32 INFO - 'HOME': '/Users/cltbld', 12:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:32 INFO - 'LOGNAME': 'cltbld', 12:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:32 INFO - 'MOZ_NO_REMOTE': '1', 12:45:32 INFO - 'NO_EM_RESTART': '1', 12:45:32 INFO - 'PAGER': '/bin/cat', 12:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:32 INFO - 'PWD': '/builds/slave/test', 12:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:32 INFO - 'SHELL': '/bin/bash', 12:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:32 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:32 INFO - 'USER': 'cltbld', 12:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:32 INFO - 'XPC_FLAGS': '0x0', 12:45:32 INFO - 'XPC_SERVICE_NAME': '0', 12:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:45:32 INFO - Cleaning up... 12:45:32 INFO - Return code: 0 12:45:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:45:32 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')]} 12:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:32 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')]} 12:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:32 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:32 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 12:45:32 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 12:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:32 INFO - 'HOME': '/Users/cltbld', 12:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:32 INFO - 'LOGNAME': 'cltbld', 12:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:32 INFO - 'MOZ_NO_REMOTE': '1', 12:45:32 INFO - 'NO_EM_RESTART': '1', 12:45:32 INFO - 'PAGER': '/bin/cat', 12:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:32 INFO - 'PWD': '/builds/slave/test', 12:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:32 INFO - 'SHELL': '/bin/bash', 12:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:32 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:32 INFO - 'USER': 'cltbld', 12:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:32 INFO - 'XPC_FLAGS': '0x0', 12:45:32 INFO - 'XPC_SERVICE_NAME': '0', 12:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:33 INFO - Downloading/unpacking blobuploader==1.2.4 12:45:33 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 12:45:33 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 12:45:33 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 12:45:33 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 12:45:33 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 12:45:33 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 12:45:35 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:35 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 12:45:35 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 12:45:35 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 12:45:35 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 12:45:35 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 12:45:35 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 12:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:45:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:36 INFO - Downloading docopt-0.6.1.tar.gz 12:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:36 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:36 INFO - Running setup.py install for blobuploader 12:45:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:45:37 INFO - Running setup.py install for requests 12:45:37 INFO - Running setup.py install for docopt 12:45:37 INFO - Successfully installed blobuploader requests docopt 12:45:37 INFO - Cleaning up... 12:45:37 INFO - Return code: 0 12:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:37 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:37 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 12:45:37 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 12:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:37 INFO - 'HOME': '/Users/cltbld', 12:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:37 INFO - 'LOGNAME': 'cltbld', 12:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:37 INFO - 'MOZ_NO_REMOTE': '1', 12:45:37 INFO - 'NO_EM_RESTART': '1', 12:45:37 INFO - 'PAGER': '/bin/cat', 12:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:37 INFO - 'PWD': '/builds/slave/test', 12:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:37 INFO - 'SHELL': '/bin/bash', 12:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:37 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:37 INFO - 'USER': 'cltbld', 12:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:37 INFO - 'XPC_FLAGS': '0x0', 12:45:37 INFO - 'XPC_SERVICE_NAME': '0', 12:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-NF3alq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-B4_Zcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-KkXR1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-KS8MJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Tg1N7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-mPa91t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-LQilAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-IngkgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:38 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-rHjUlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Dz06Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-9Bcifo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-10tbHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-xTSK35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-b1ge7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-tx5Wa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-0cnlkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:39 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-8Xe6ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:45:39 INFO - Running setup.py install for manifestparser 12:45:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:45:40 INFO - Running setup.py install for mozcrash 12:45:40 INFO - Running setup.py install for mozdebug 12:45:40 INFO - Running setup.py install for mozdevice 12:45:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:45:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:45:40 INFO - Running setup.py install for mozfile 12:45:40 INFO - Running setup.py install for mozhttpd 12:45:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:45:40 INFO - Running setup.py install for mozinfo 12:45:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:45:40 INFO - Running setup.py install for mozInstall 12:45:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozleak 12:45:41 INFO - Running setup.py install for mozlog 12:45:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for moznetwork 12:45:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozprocess 12:45:41 INFO - Running setup.py install for mozprofile 12:45:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:45:41 INFO - Running setup.py install for mozrunner 12:45:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Running setup.py install for mozscreenshot 12:45:42 INFO - Running setup.py install for moztest 12:45:42 INFO - Running setup.py install for mozversion 12:45:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:45:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:45:42 INFO - Cleaning up... 12:45:42 INFO - Return code: 0 12:45:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:42 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')]} 12:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:42 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')]} 12:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:42 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:42 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 12:45:42 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 12:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:42 INFO - 'HOME': '/Users/cltbld', 12:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:42 INFO - 'LOGNAME': 'cltbld', 12:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:42 INFO - 'MOZ_NO_REMOTE': '1', 12:45:42 INFO - 'NO_EM_RESTART': '1', 12:45:42 INFO - 'PAGER': '/bin/cat', 12:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:42 INFO - 'PWD': '/builds/slave/test', 12:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:42 INFO - 'SHELL': '/bin/bash', 12:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:42 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:42 INFO - 'USER': 'cltbld', 12:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:42 INFO - 'XPC_FLAGS': '0x0', 12:45:42 INFO - 'XPC_SERVICE_NAME': '0', 12:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-wPkGyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:42 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)) 12:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-hPP7N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:42 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)) 12:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:42 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-I0nR5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-80OHoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-18G9mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-pMC3H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-8IOojr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ZZNA5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-cftLPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-rW79rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-m_T1Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:43 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)) 12:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:43 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Lf0B3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-_nOQmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-xXXwMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-CISMYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-1vN0al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:44 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)) 12:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-DIk97a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 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)) 12:45:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:47 INFO - Downloading blessings-1.6.tar.gz 12:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:45:47 INFO - Installing collected packages: blessings 12:45:47 INFO - Running setup.py install for blessings 12:45:47 INFO - Successfully installed blessings 12:45:47 INFO - Cleaning up... 12:45:47 INFO - Return code: 0 12:45:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:47 INFO - Reading from file tmpfile_stdout 12:45:47 INFO - Current package versions: 12:45:47 INFO - blessings == 1.6 12:45:47 INFO - blobuploader == 1.2.4 12:45:47 INFO - docopt == 0.6.1 12:45:47 INFO - functools32 == 3.2.3-2 12:45:47 INFO - jsonschema == 2.5.1 12:45:47 INFO - manifestparser == 1.1 12:45:47 INFO - mozInstall == 1.12 12:45:47 INFO - mozcrash == 0.17 12:45:47 INFO - mozdebug == 0.1 12:45:47 INFO - mozdevice == 0.48 12:45:47 INFO - mozfile == 1.2 12:45:47 INFO - mozhttpd == 0.7 12:45:47 INFO - mozinfo == 0.9 12:45:47 INFO - mozleak == 0.1 12:45:47 INFO - mozlog == 3.4 12:45:47 INFO - moznetwork == 0.27 12:45:47 INFO - mozprocess == 0.23 12:45:47 INFO - mozprofile == 0.28 12:45:47 INFO - mozrunner == 6.12 12:45:47 INFO - mozscreenshot == 0.1 12:45:47 INFO - mozsystemmonitor == 0.3 12:45:47 INFO - moztest == 0.7 12:45:47 INFO - mozversion == 1.4 12:45:47 INFO - psutil == 3.1.1 12:45:47 INFO - requests == 1.2.3 12:45:47 INFO - wsgiref == 0.1.2 12:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 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 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:47 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 12:45:47 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 12:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:47 INFO - 'HOME': '/Users/cltbld', 12:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:47 INFO - 'LOGNAME': 'cltbld', 12:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:47 INFO - 'MOZ_NO_REMOTE': '1', 12:45:47 INFO - 'NO_EM_RESTART': '1', 12:45:47 INFO - 'PAGER': '/bin/cat', 12:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:47 INFO - 'PWD': '/builds/slave/test', 12:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:47 INFO - 'SHELL': '/bin/bash', 12:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:47 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:47 INFO - 'USER': 'cltbld', 12:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:47 INFO - 'XPC_FLAGS': '0x0', 12:45:47 INFO - 'XPC_SERVICE_NAME': '0', 12:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 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)) 12:45:47 INFO - Cleaning up... 12:45:47 INFO - Return code: 0 12:45:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101431490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013a7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfabc9da10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, '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.JzLPKSNv75/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.AcmjpixyUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 12:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:45:47 INFO - 'HOME': '/Users/cltbld', 12:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:45:47 INFO - 'LOGNAME': 'cltbld', 12:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:47 INFO - 'MOZ_NO_REMOTE': '1', 12:45:47 INFO - 'NO_EM_RESTART': '1', 12:45:47 INFO - 'PAGER': '/bin/cat', 12:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:47 INFO - 'PWD': '/builds/slave/test', 12:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:45:47 INFO - 'SHELL': '/bin/bash', 12:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:45:47 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:45:47 INFO - 'USER': 'cltbld', 12:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:47 INFO - 'XPC_FLAGS': '0x0', 12:45:47 INFO - 'XPC_SERVICE_NAME': '0', 12:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:45:48 INFO - Cleaning up... 12:45:48 INFO - Return code: 0 12:45:48 INFO - Running post-action listener: _resource_record_post_action 12:45:48 INFO - Running post-action listener: _start_resource_monitoring 12:45:48 INFO - Starting resource monitoring. 12:45:48 INFO - [mozharness: 2016-10-03 19:45:48.225488Z] Finished create-virtualenv step (success) 12:45:48 INFO - [mozharness: 2016-10-03 19:45:48.226464Z] Running install step. 12:45:48 INFO - Running pre-action listener: _resource_record_pre_action 12:45:48 INFO - Running main action method: install 12:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:48 INFO - Reading from file tmpfile_stdout 12:45:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:45:48 INFO - Reading from file tmpfile_stdout 12:45:48 INFO - Output received: 12:45:48 INFO - Usage: mozinstall [options] installer 12:45:48 INFO - Options: 12:45:48 INFO - -h, --help show this help message and exit 12:45:48 INFO - -d DEST, --destination=DEST 12:45:48 INFO - Directory to install application into. [default: 12:45:48 INFO - "/builds/slave/test"] 12:45:48 INFO - --app=APP Application being installed. [default: firefox] 12:45:48 INFO - mkdir: /builds/slave/test/build/application 12:45:48 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'] 12:45:48 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 12:46:20 INFO - Reading from file tmpfile_stdout 12:46:20 INFO - Output received: 12:46:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:46:20 INFO - Running post-action listener: _resource_record_post_action 12:46:20 INFO - [mozharness: 2016-10-03 19:46:20.787289Z] Finished install step (success) 12:46:20 INFO - [mozharness: 2016-10-03 19:46:20.787409Z] Running run-tests step. 12:46:20 INFO - Running pre-action listener: _resource_record_pre_action 12:46:20 INFO - Running main action method: run_tests 12:46:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:46:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:46:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:46:20 INFO - 2016-10-03 12:46:20.802 screenresolution[1642:8327] starting screenresolution argv=screenresolution get 12:46:20 INFO - 2016-10-03 12:46:20.804 screenresolution[1642:8327] Display 0: 1600x1200x32@60 12:46:20 INFO - 2016-10-03 12:46:20.811 screenresolution[1643:8330] starting screenresolution argv=screenresolution list 12:46:20 INFO - Available Modes on Display 0 12:46:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:46:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:46:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:46:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:46:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:46:21 INFO - Intel Iris: 12:46:21 INFO - Chipset Model: Intel Iris 12:46:21 INFO - Type: GPU 12:46:21 INFO - Bus: Built-In 12:46:21 INFO - VRAM (Dynamic, Max): 1536 MB 12:46:21 INFO - Vendor: Intel (0x8086) 12:46:21 INFO - Device ID: 0x0a2e 12:46:21 INFO - Revision ID: 0x0009 12:46:21 INFO - Displays: 12:46:21 INFO - Display: 12:46:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:46:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:46:21 INFO - Display Serial Number: 1600x1200 60 12:46:21 INFO - Main Display: Yes 12:46:21 INFO - Mirror: Off 12:46:21 INFO - Online: Yes 12:46:21 INFO - Rotation: Supported 12:46:21 INFO - Return code: 0 12:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:21 INFO - Python 2.7.3 12:46:21 INFO - Return code: 0 12:46:21 INFO - grabbing minidump binary from tooltool 12:46:21 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')]} 12:46:21 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 0x101245d30>, '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 0x1010abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10123db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46:21 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 12:46:21 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 12:46:21 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 12:46:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:21 INFO - Return code: 0 12:46:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:46:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:46:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46:21 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/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 12:46:21 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/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0326 --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 12:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JzLPKSNv75/Render', 12:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:46:21 INFO - 'HOME': '/Users/cltbld', 12:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:46:21 INFO - 'LOGNAME': 'cltbld', 12:46:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:21 INFO - 'MOZ_NO_REMOTE': '1', 12:46:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:21 INFO - 'NO_EM_RESTART': '1', 12:46:21 INFO - 'PAGER': '/bin/cat', 12:46:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:21 INFO - 'PWD': '/builds/slave/test', 12:46:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:46:21 INFO - 'SHELL': '/bin/bash', 12:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AcmjpixyUz/Listeners', 12:46:21 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 12:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:46:21 INFO - 'USER': 'cltbld', 12:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:21 INFO - 'XPC_FLAGS': '0x0', 12:46:21 INFO - 'XPC_SERVICE_NAME': '0', 12:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:46:21 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/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--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 12:46:21 INFO - mozversion application_buildid: 20161003103758 12:46:21 INFO - mozversion application_changeset: ba4c1706898b4b7edcca633e2844e6ee12556cb9 12:46:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:46:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:21 INFO - mozversion application_name: Firefox 12:46:21 INFO - mozversion application_remotingname: firefox-dev 12:46:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:46:21 INFO - mozversion application_vendor: Mozilla 12:46:21 INFO - mozversion application_version: 51.0a2 12:46:21 INFO - mozversion platform_buildid: 20161003103758 12:46:21 INFO - mozversion platform_changeset: ba4c1706898b4b7edcca633e2844e6ee12556cb9 12:46:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:46:21 INFO - mozversion platform_version: 51.0a2 12:46:21 INFO - using testdate: 1475523981 12:46:21 INFO - actual date: 1475523981 12:46:21 INFO - starting webserver on 'localhost:49271' 12:46:21 INFO - SUITE-START | Running 2 tests 12:46:21 INFO - TEST-START | dromaeo_css 12:46:21 INFO - operating with platform_type : mac_ 12:46:21 INFO - Initialising browser for dromaeo_css test... 12:46:21 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp74KLSM/profile http://localhost:49271/getInfo.html) 12:46:23 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 12:46:23 INFO - PROCESS | 1653 | colorDepth:24 12:46:23 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 12:46:23 INFO - PROCESS | 1653 | __metrics 12:46:23 INFO - PROCESS | 1653 | 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" 12:46:23 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:24 INFO - TEST-INFO | 1653: exit 0 12:46:24 INFO - Browser initialized. 12:46:24 INFO - Running cycle 1/1 for dromaeo_css test... 12:46:24 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp74KLSM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:36 INFO - PROCESS | 1656 | RSS: Main: 219144192 12:46:36 INFO - PROCESS | 1656 | 12:47:27 INFO - PROCESS | 1656 | 1475524047699 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] 12:49:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 12:49:41 INFO - PROCESS | 1656 | RSS: Main: 372273152 12:49:41 INFO - PROCESS | 1656 | 12:52:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 12:52:45 INFO - PROCESS | 1656 | RSS: Main: 352202752 12:52:45 INFO - PROCESS | 1656 | 12:55:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 12:55:48 INFO - PROCESS | 1656 | RSS: Main: 323223552 12:55:48 INFO - PROCESS | 1656 | 12:58:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:58:50 INFO - PROCESS | 1656 | RSS: Main: 321118208 12:58:50 INFO - PROCESS | 1656 | 13:01:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 13:01:54 INFO - PROCESS | 1656 | RSS: Main: 311918592 13:01:54 INFO - PROCESS | 1656 | 13:04:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 13:04:58 INFO - PROCESS | 1656 | RSS: Main: 389754880 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | __start_tp_report 13:04:58 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 13:04:58 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 13:04:58 INFO - PROCESS | 1656 | |i|pagename|runs| 13:04:58 INFO - PROCESS | 1656 | |0;dojo.html;2853.2438903690527;3347.7489188310874;3370.713489353405;3407.8807241746545;3427.2802711430613;5701.971490142549;5735.971320143399;5773.047447171222;5791.855203619912;5814.982378083834;5681.062624666925;5746.540276777858;5746.655200687951;5755.39568345324;5760.683162426065;5231.555317797992;5253.789848406059;5264.6051546134095;5290.814821481249;5306.602004849632;5218.347706536683;5239.607029472786;5325.547328477065;5328.520433161015;5345.4387289334645;5228.137357336035;5272.894542109156;5279.076161671711;5286.735663216843;5300.151975683892;5318.361796584415;5319.521243088141;5351.438098999627;5352.437994010612;5364.141737322048;5147.330846989905;5203.245529398254;5269.815556455544;5296.629235953485;5300.814471493479;5623.887522249573;5624.072028115397;5699.886002279973;5709.800156994527;5733.713314334266;6241.3446588108045;6266.279377871558;6273.05904114382;6301.338359472235;6349.809505714836;6284.497240220817;6330.525210609223;6342.714577844008;6355.491560675135;6367.968160159169;5653.745581448845;5735;5735.569832262555;5809;5817.7382017809305;6290.55966082379;6316.147320111726;6317.778877739349;6320.873582528416;6334.9366506334345;6184.226971628546;6195.256569211723;6206.875862482725;6207.968960155261;6218.347073557302;6162.291336496271;6196.752129914843;6248.812535623939;6284.025975973731;6303.495720342362;6236.875262494725;6260.342664020303;6319.399657032574;6323.810285691345;6325.272593651697;6275.529335299871;6326.145970294044;6353.5234857385885;6356.141920840627;6357.554971152067;4882.6826256293225;4907.092187945242;4917.58200552957;4997.530667118971;5020.949790502122;4425.690201685916;4466.3747075409465;4473.015936493966;4477.2164871147415;4500.212462819059;5826.621269617462;5832.358440571534;5842.298924129047;5856.305816051161;5866.970665146732;6168.1056246843955;6312.652804095727;6314.905276420857;6324.3991820776955;6343.55595108338;5658.7170641467765;5754.942450575524;5805.970970145122;5819.330776960704;5892.204552385459;5451.972740136353;5488.039593071197;5498.092814685612;5514.944850551443;5515.61390702647;6381.978883378637;6402;6402.231732192166;6409.262934762562;6426.582272152295;6142.652254521207;6153.692315384303;6204.069389591416;6249;6288.65412402304;6267.1539342188225;6300.7479700811455;6324;6394.808155755335;6403.551751377545;6244.968775156095;6253.062040693932;6269.592476489013;6274.1843560336865;6278.905816412666;6293.685315734287;6311.589746666452;6342.587731797418;6366.140571022853;6366.6180029198395;5991.370906054975;6044.576879618385;6100.115483254992;6140.109684095871;6151.876962460815;6179.196704428396;6183.938160618516;6204.317525072329;6211.192544969125;6211.9068213975925;6009.158717779427;6045.727942242522;6092.390760923872;6100.450959413674;6114.57197996136;5890.676012819336;5975.133605627247;6085.361037091042;6086.695665216633;6183.103449999815;5186.2479940407675;5994.940050599438;6004.849878753066;6012.1582978382185;6054.727537260922 13:04:58 INFO - PROCESS | 1656 | |1;ext.html;485.46113813666835;512.9051125541775;519.6596229469694;524.334095698463;562.2241306996342;30211;39961.80019099908;41158.794206029;41287.79356103223;43370.56629433705;42508.78745606275;42680.719578412616;42747.14505709884;42831.571684283146;42983.57016429835;9773.999999999982;9946.104850563448;9949.850752238723;9950.353227040256;9973.102420782128;8763.912360876373;8959.41763785352;12096.092793040558;12298.508059677602;12310.569130080448;12101.818472722873;12164.81752773709;12184;12215.450304736263;12218.816717749241;12132.636020919343;12194.695132621666;12205.755884882252;12227.14409991301;12251.509939602405;8690.695825646135;8888.955555222246;11813.881861181364;12057.698557536043;12084.939575302154;39763.60236397628;40124.796256112364;40169.59830401688;40171.59828401737;40173;3092.6288845338477;3281.376538457709;3359.6640335966454;3538.876139335111;3607.1162565171703;29968.400631987457;31282.687173128204;31457.21356966094;31655.36689266225;31999.52000719991;3216.7748257621975;3221.903342899717;3271.329377477611;3287.408266512027;3308.801471911669;521534;522677;524284.99999999616;524946;525015;59926;60282.69858650678;60354;60470.79058418807;60576;63844.68077659582;63855.680721596094;63862.36137638657;64057;64088.67955660192;16113.67772644564;16507.587310317096;16535.917320413322;16543;16547.172641367884;11559.711007224887;12819.423125959167;12888.548900788428;12896.29070401137;12897;14656.780148297785;15168.31742571587;15515.922420387826;16360.836391635932;17188.31246750141;5984.521238300926;6045.667488288186;6112.174856394418;6117.418845209698;6147.44672979434;702.6592102830124;935.5228833295068;1033.256055639938;1048.6539441984128;1071.8713754349528;28979;30022.84988575043;30162;30820.383592328475;30833.84583077115;1011.8633984412011;1026.685842122085;1082.6643740440488;1093.2183488805383;1142.731458107344;12888.871111288954;15289.847101528841;15480.84519154794;15620.062796232036;15899.920500397424;679676;683105;683415.5829220922;683780;938937;47483.52516474791;55947.44052559504;56973.715131424906;56994.7150264246;59744.40255597475;1330.7937269723209;1344.5764584155959;1370.7738223193062;1371.348609410542;1377.1186440678175;29781.5532767013;31023;31050.68949310478;31189.220269493446;31733.04800855978;49293;49617;49691;49834;49848.750756247435;621509;624750;625848.8707556434;626018;626301;39152.80423597864;39613.40579891361;39929;40032.1993560133;40186.39720404255;46334;46391.53608463872;46874;46920.530794691615;47068.7646561765;33772.32455350929;37668.81165594154;37760.62239377681;39745.60254397419;39926.60073399345;36199.81900090483;37870.50877622784;38270;38925.8053709741;39560.60439395684;37366.439503406924;37712.81143594265;38367.42448863213;38687;39738.40392394058;32553.674463255065;33903.830480848424;34552.16269722291;34765.826170869994;34902.65097348994;19717.309894153637;25596.8720156398;25768.226953191435;26061.348466288495;26107.608385874606 13:04:58 INFO - PROCESS | 1656 | |2;jquery.html;353.2863615496695;370.18005118662165;374.5542804063165;381.7747528957915;400.869717341864;12764.489420423184;15101.395944162234;16130.27413766379;20303.57874948754;20718.792812071875;17234.655306893856;20618.896905515452;20889.791102088973;21350.786492135074;21685.024173912174;5016.072026675059;5803.564732645058;6177.660228687443;6192.876142477147;6194.876102477948;6018.7893423730175;6077.24034495688;6086.817395478142;6120.234970628671;6173.506119510451;5721.485066344028;5906.173135760997;5966.67183304918;6005.699715014253;6024.8493787655225;6010.939890601082;6068.059450785136;6077.301110372297;6079.392060793907;6092.817215483543;5038.974805125988;5198.116320225571;5265.76304066318;5266.736663166865;5298.390685071189;19165.520861978563;23195.76804231953;23469.06123755048;25452.745472545408;25671.358216044562;2131.5204079082237;2213.82343262298;2334.9066037358484;2340.2862127051244;2388.868612226327;9821.558029888673;9926.45404502752;10165.135963443116;10418.635347762793;13942.860571394258;1801.5676237702987;1827.2416946966994;1842.3183422133895;1896.7344571759966;1900.0879577802732;79240.60379698065;87030.69453958132;122179.26818304417;123654.76345236522;125019;9293.767655808524;11570.94214528922;11609.825852612217;11766.941165294118;11912.344821034752;14818.25908704582;14851.2574371281;14853.48012819546;14861.554153375417;14873.256337183098;7035.472339574552;8436.409451338348;8598.656053757904;8611.95694021526;8698.086700896441;8418.368622353348;8426.578671066422;8535;8541.615627296787;8655.047944726075;4496.977515112403;4592.334111553806;4602.723836569817;4616.584507394351;4685.648576356719;1625.9431369609613;1780.9643807123784;1875.278017963094;1903.5336342595876;1918.7121931710356;716.9211386747454;846.593635055177;922.8154369126067;949.0793929887998;971.5239532629103;20404;21877.453063673536;22027.66958495624;22030.779692203192;22133.446663833533;899.7255836969656;915.9404638698463;917.6650522559218;1008.1732978957331;1055.5724931402794;10408.323458975143;11324.15068869838;11386.146039047104;11529.596464123882;11572.36352000648;613271;614456;621922;628777;630841;107774;129520.3523982393;131680.3415982914;140159.29920350536;140962.2951885234;949.1552518258756;953.952302384878;981.1954197558076;982.6560703753629;983.341161421849;18686.43940681782;19056.237750489825;19160.23359065622;19164.616707666046;19221.519462013563;53064.73467632637;54130.729346353015;54246.72876635592;54493.36806371503;55199.17201242065;80569.90435241458;80693;81524.59237703774;84072;84473.73289400787;8011.399145064027;8179.222973817477;8217.178282171735;8250.752477425447;8336.29141522953;10636.946815265874;11940.10449216295;12601.810972835232;12681.80977285323;12903.612891613267;10648.84026739584;10879.51042203087;11273.549058037586;11310.717232069264;11444.542218311175;10849.294795838245;11054.115670746482;11171.832422513831;11209.831852522055;11381.658550243506;9554.235661146953;10794.56821727122;11351;11375.488103035217;11693.76612467763;8031.919680803117;8067.435279530377;8098.473599216032;8247.546384948886;8308.958455207685;9683.806323873623;10841.241113122005;11041.889581104408;11044.282121662067;11276.830847537458 13:04:58 INFO - PROCESS | 1656 | |3;mootools.html;1527.25164669312;1548.8683461905737;1763.2682436788734;1874.1940965384879;1917.1660327757418;8771.780705482359;9297.349185557014;9298.16316531512;9300.255979521638;9313.627454901813;8094.635741391637;8361.749147525568;8363.289120424772;8909.287257019423;9114.31642626804;2409.722881868581;2438.6585877977095;2443.2059580636273;2446.217210492643;2446.2538925627678;2013.6778115501522;2373.4303767095857;2387.9761202388013;2433.415980164765;2439.0975339124548;1747.9038652874087;2204.0522575292616;2355.199232261031;2427.8421902576365;2429.5505331513637;2409.650600662903;2435.5981263091567;2435.987820060906;2437.2810021043747;2440.060576677992;2403.098837935774;2441.9389515262083;2442.5481285962155;2443.2914454808083;2443.8289319747623;9059.954700226523;9149.130832570962;9155.587998540082;9191.678291259774;9238.538073096319;5342.893142137135;5507.091329930557;5507.201455788928;5510.6969116698565;5517.613767036309;3399.6940275375337;3699.408094704834;3809.3143234218105;3828.7894165820867;3835.5972622874474;1111.0778054215064;1133.167122165208;1534.8695360894337;1785.9017754023523;1892.5268682829292;12214.572489962897;12325.075619328587;12338.99999999991;12351.32067736274;12374;4584.381108550303;4647.744374059459;4713.835015774432;4760.64295177863;4790.209615413488;9487.525623718786;9491.715248542554;9518.524073796283;9521.523923803783;9521.904780952102;5389.110796718576;5393.325834270716;5393.352797664227;5399.514043736004;5404.486573775485;4929.482404347564;4931.112399768076;5041.924371134436;5044.495550445;5063.012712521097;3704;3718.1262403335195;3719.20037192005;3816.656500914931;3824.827882745283;1166.877477864829;1167.5563285951284;1171.9589814356457;1185.946632401544;1188.4236145469613;587.7795826565039;758.8406434648675;905.5924833824805;911.589784596934;942.137943781446;5780.393058728773;5832.270966129234;6014.368491308437;6144.846378840565;6192.938070619236;477.17925168709763;492.4091090691185;492.85214435669155;493.71858040916334;610.8790369671614;3898.922021559553;3968.920621587552;4043.1913617276664;4101.077257617012;4144.52337981136;10755.354678719303;11284.21010529255;11285.266457680225;11309.717257068474;11311.321320720783;11216.495257713423;11219.1585631078;11246.775064498665;11252.606158784567;11253.156013299036;8167.71413000554;8454.15458454162;8572.485650860968;8601.913980860236;8612.181842725056;5836.854078647898;5888.116782482491;5954.3152537458745;6090.299615544269;6109.266887973472;10243.43661098617;10356.637517686844;10469.738256543647;10483.161347092368;10511.684649460529;10493.003164699647;10685.839712404475;10721.195910306915;10736.355818650905;10756.83864742045;7099.858002840017;7178.318059784312;7184.568925864465;7186.10173728284;7190.532615379983;8188.713395031145;8360.916390836013;8421.284190843848;8431.451955622864;8526.488410695378;7721.150673425806;7878.290953814184;7919.485233459806;8007.879881801894;8068.193180681885;6357.8728425432155;7808.180141085104;7855.332296754611;7893.092294386219;7941.722039728582;7038.648067596702;7108.111486064242;7202.135743710788;7204.027456293543;7204.063471748639;5129;5194.714290714047;5320.44135365781;5322.520973112439;5367;4610.377599024089;5263.499967503081;5283.86396924663;5363.988489380669;5374.516293533601 13:04:58 INFO - PROCESS | 1656 | |4;prototype.html;279.99860000699994;302.26851020530313;304.49301912315997;311.8658976640045;315.5723993988146;5138.023775482656;5229.294045303883;5362.544183744377;5450.754716037778;5485.478879506445;4051.615096565829;4369.759663218521;4871.757701786039;5202.921956170651;5248.737563121847;3038.6049813524264;3617.656322649344;4096.221717873609;4109.027666719976;4202.411662367271;3932.6460618544324;4108.178364327132;4118.341065429532;4123.525794533622;4126.31915733905;4108.712390132692;4122.917541649165;4146.937795933063;4171.416001759756;4206.548740684474;4117.17656468706;4117.341225403936;4145.481814773153;4156.43888075109;4170.4995400551825;3626;3631;3632.4914511968345;3635.563732352108;3643.7813731175947;4276.5295817460055;4508.481524624677;4832.85501434954;5302.708351040691;5308.442613525563;4306.246406878815;4582.6104781093645;4736.478987311393;4756.262779269219;4759.357486739281;4685.601723853477;5287.286216360781;5612.719364031782;5644.181593668936;5667.829965101054;3849.615038496156;3937.7046721496004;3950.392740791064;3971.543272523639;3995.1610161866042;5122.308488354061;5695.917775622618;5879.764809407661;5907.274180655501;5911.290645122613;4039.1719697462536;4039.5152581690386;4040.5555388907196;4060.7360521566;4069.552349241581;3542.6634469725336;3588.205897051474;4022.0950286185375;4120.814563344657;4128.876133715993;4615.869112067565;4700.741459219707;4703.7883295251795;4708.587423772855;4710.9764451177525;5651.321841379061;5677.545796336283;5710.087855193798;5740.253767010262;5765.281393501168;1261.7791886420023;1325.681836359286;1358.213948657532;1391.5616580777225;1408.6688079764729;767.5049593012476;783.9725609603637;879.907609700985;889.4929889962789;890.425675439338;3913.9021524462114;4052.1085361220485;4407.933880991788;4493.056458143761;4501.68488205829;4157.771322577227;4461.665375096881;4562.931556026662;4655.462772788838;4922.505021434821;4201.474815648044;5387.218853266255;5388.407275199725;5414.593905457106;5422.674639521641;3031.7262053459904;3061.632604087479;3069.202007478027;3070.650952021705;3088.2279430142466;5364.302640656768;5694.800681976111;5752.971235143881;5868.706564671749;5924.881502369928;5934.7922822701;5964.284285885721;5967.671778052162;5975.850603734854;5979.5814292999075;4603.401557797465;5323.893522129536;6018.789342372996;6021.862238905301;6047.7278522466595;5108.3103780989095;5346.411894691659;5514.889702206014;5724.542036636975;5791.160281759037;4990.777259571283;5553.805616803393;5731.971340143273;5749.942500574941;5811.912821307599;5605.579581531483;5733.426657334233;5945.781114871527;5997.340292567901;6045.274567051982;3851.980740096282;3869.864554740683;3874.8837534874;3876.6511014008875;3878.670313023312;5774.133879918046;5781.364049954417;5799.797007104731;5814.273215848019;5834.445727655866;5358.598105142052;5403.216533602685;5434.717418684241;5648.5481161507805;5659.717014149193;4492.663050271308;5173.663711858717;5476.123820188751;5615.2700148980375;5622.240997465454;4361.037533110177;4763.809447622057;4787.521247875324;4958.851234462972;5314.910443359025;5371.328583927009;5488.506034456918;5508.228847961369;5649.971750141223;5655.462731040545;4872.294696856214;5210.515003224063;5258.6581872178185;5439.456054394529;5535.446455354593 13:04:58 INFO - PROCESS | 1656 | |5;yui.html;702.3573430311263;753.1376573822973;781.3631890009646;800.1318569352253;815.0748899998501;15002.849971500282;15249.771253431207;15864.365425382985;15896.205189740496;16203.027818330878;14385.92807035966;14790.778138327934;14797.482088126917;14806.851931480682;14811;655.8130932684186;670.580886945659;811.0591713612225;836.4145098431092;840.6301227459928;671.8824205763996;672.2907332763932;674.430106559956;675.598019178588;815.559597817178;729.5513259345491;890.6971629645919;895.2703546609492;897.3135551303258;898.0704970355683;882.9690960816405;885.0441523155041;886.0165216609558;889.2885691446849;889.3285569395065;506.541579870218;521.7912834866046;651.690447037658;651.9804405867784;655.7934250711058;14633.41466341345;14935.477258295907;14961.551153465305;14972.925135374253;15540.844591554052;11237.3257604544;13907;14374.281285935662;14405.423783048665;14841.406343746237;12400.255984640951;12756.170848894792;12829.23024618526;12948.352582370939;13454.596362109152;4077.9592204077876;4585.70192937458;4603.700759450625;4637.652176086807;4800.495947925452;114335;118352.40823795913;119064;120952;122296.55406891901;11004.284721493077;11154.10767138627;11323.943380283046;11350.716232094264;11462.885371146349;18434.90782546079;22490.550188996454;22560.66159007616;22612.547749044927;22725.318240452812;6686.69609426167;7284.562926224444;7914.722984695508;8067.031956165298;8224.712135075244;4175.206710724952;4256.1487702459635;4290.914181716348;4334.371516130143;4413.845515406945;3621.7464777465852;3696.6857817085847;3796.6962642988497;3803.9619603804163;3805.7145714071557;671.4359937652298;674.8953912143626;677.6747161362475;686.114911763829;694.482610455204;490.8920037591724;557.4759725857681;667.2360147630935;678.2945736434152;678.4835891781863;8589.484630922165;9131.589078491485;9556.378835375679;9607.615695372107;9788.55951482185;562.3224015061923;568.5536853569928;644.9709763060673;652.5236577298599;671.3051991189096;3648.9635103648625;4317.287647538184;4565.6119229865835;4573.519780423074;4709.764511774398;90473.54763226141;122699;162506;166072.16963915102;171226;136866.315668421;140955;141612;146881;148899;120341;120649.1902621479;121884.56961325706;128074.71925280814;129209;8757.09313573934;8848.734537963872;8949.373543851867;8951.283897288331;8961.23829474502;66179.66910165419;67568.66215668891;67651.32348676647;68172.65913670599;71188.93216601858;101798.4910075445;102981;103037.48481257545;106681;110108.89891100986;11864.822027669765;12052.939735301268;12067.275963442222;12125.81811272814;12520.561780337644;12816.102872798814;13014.21914685122;13404.798928015893;14628.488002919847;14673.706525869637;14006.649833754238;14075.648108797363;14321.069130506483;14713.705725885207;14928.552143435714;13580.25308608036;13766.692164244381;13920.443182273;14080.577582672537;14183.574492765234;13240.337983100999;13980.650483737987;14062;14131;14669.853301466848;11131.610393636183;11295.322280663186;11820.113491488344;11993.790463069756;12018.158728888893;11183.88816111861;11527.711807204552;11651.766964660828;11810.527578896748;11992.940035299767 13:04:58 INFO - PROCESS | 1656 | __end_tp_report 13:04:58 INFO - PROCESS | 1656 | __start_cc_report 13:04:58 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1488 13:04:58 INFO - PROCESS | 1656 | __end_cc_report 13:04:58 INFO - PROCESS | 1656 | __startTimestamp1475525098125__endTimestamp 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | ------- Summary: start ------- 13:04:58 INFO - PROCESS | 1656 | Number of tests: 6 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5796.07 Median:6012.16 stddev:656.51 (10.9%) stddev-sans-first:616.60 13:04:58 INFO - PROCESS | 1656 | Values: 2853.2 3347.7 3370.7 3407.9 3427.3 5702.0 5736.0 5773.0 5791.9 5815.0 5681.1 5746.5 5746.7 5755.4 5760.7 5231.6 5253.8 5264.6 5290.8 5306.6 5218.3 5239.6 5325.5 5328.5 5345.4 5228.1 5272.9 5279.1 5286.7 5300.2 5318.4 5319.5 5351.4 5352.4 5364.1 5147.3 5203.2 5269.8 5296.6 5300.8 5623.9 5624.1 5699.9 5709.8 5733.7 6241.3 6266.3 6273.1 6301.3 6349.8 6284.5 6330.5 6342.7 6355.5 6368.0 5653.7 5735.0 5735.6 5809.0 5817.7 6290.6 6316.1 6317.8 6320.9 6334.9 6184.2 6195.3 6206.9 6208.0 6218.3 6162.3 6196.8 6248.8 6284.0 6303.5 6236.9 6260.3 6319.4 6323.8 6325.3 6275.5 6326.1 6353.5 6356.1 6357.6 4882.7 4907.1 4917.6 4997.5 5020.9 4425.7 4466.4 4473.0 4477.2 4500.2 5826.6 5832.4 5842.3 5856.3 5867.0 6168.1 6312.7 6314.9 6324.4 6343.6 5658.7 5754.9 5806.0 5819.3 5892.2 5452.0 5488.0 5498.1 5514.9 5515.6 6382.0 6402.0 6402.2 6409.3 6426.6 6142.7 6153.7 6204.1 6249.0 6288.7 6267.2 6300.7 6324.0 6394.8 6403.6 6245.0 6253.1 6269.6 6274.2 6278.9 6293.7 6311.6 6342.6 6366.1 6366.6 5991.4 6044.6 6100.1 6140.1 6151.9 6179.2 6183.9 6204.3 6211.2 6211.9 6009.2 6045.7 6092.4 6100.5 6114.6 5890.7 5975.1 6085.4 6086.7 6183.1 5186.2 5994.9 6004.8 6012.2 6054.7 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:75503.47 Median:37815.57 stddev:170532.15 (451.0%) stddev-sans-first:170917.52 13:04:58 INFO - PROCESS | 1656 | Values: 485.5 512.9 519.7 524.3 562.2 30211.0 39961.8 41158.8 41287.8 43370.6 42508.8 42680.7 42747.1 42831.6 42983.6 9774.0 9946.1 9949.9 9950.4 9973.1 8763.9 8959.4 12096.1 12298.5 12310.6 12101.8 12164.8 12184.0 12215.5 12218.8 12132.6 12194.7 12205.8 12227.1 12251.5 8690.7 8889.0 11813.9 12057.7 12084.9 39763.6 40124.8 40169.6 40171.6 40173.0 3092.6 3281.4 3359.7 3538.9 3607.1 29968.4 31282.7 31457.2 31655.4 31999.5 3216.8 3221.9 3271.3 3287.4 3308.8 521534.0 522677.0 524285.0 524946.0 525015.0 59926.0 60282.7 60354.0 60470.8 60576.0 63844.7 63855.7 63862.4 64057.0 64088.7 16113.7 16507.6 16535.9 16543.0 16547.2 11559.7 12819.4 12888.5 12896.3 12897.0 14656.8 15168.3 15515.9 16360.8 17188.3 5984.5 6045.7 6112.2 6117.4 6147.4 702.7 935.5 1033.3 1048.7 1071.9 28979.0 30022.8 30162.0 30820.4 30833.8 1011.9 1026.7 1082.7 1093.2 1142.7 12888.9 15289.8 15480.8 15620.1 15899.9 679676.0 683105.0 683415.6 683780.0 938937.0 47483.5 55947.4 56973.7 56994.7 59744.4 1330.8 1344.6 1370.8 1371.3 1377.1 29781.6 31023.0 31050.7 31189.2 31733.0 49293.0 49617.0 49691.0 49834.0 49848.8 621509.0 624750.0 625848.9 626018.0 626301.0 39152.8 39613.4 39929.0 40032.2 40186.4 46334.0 46391.5 46874.0 46920.5 47068.8 33772.3 37668.8 37760.6 39745.6 39926.6 36199.8 37870.5 38270.0 38925.8 39560.6 37366.4 37712.8 38367.4 38687.0 39738.4 32553.7 33903.8 34552.2 34765.8 34902.7 19717.3 25596.9 25768.2 26061.3 26107.6 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:35490.68 Median:361.73 stddev:103556.96 (28628.0%) stddev-sans-first:103813.86 13:04:58 INFO - PROCESS | 1656 | Values: 353.3 370.2 374.6 381.8 400.9 12764.5 15101.4 16130.3 20303.6 20718.8 17234.7 20618.9 20889.8 21350.8 21685.0 5016.1 5803.6 6177.7 6192.9 6194.9 6018.8 6077.2 6086.8 6120.2 6173.5 5721.5 5906.2 5966.7 6005.7 6024.8 6010.9 6068.1 6077.3 6079.4 6092.8 5039.0 5198.1 5265.8 5266.7 5298.4 19165.5 23195.8 23469.1 25452.7 25671.4 2131.5 2213.8 2334.9 2340.3 2388.9 9821.6 9926.5 10165.1 10418.6 13942.9 1801.6 1827.2 1842.3 1896.7 1900.1 79240.6 87030.7 122179.3 123654.8 125019.0 9293.8 11570.9 11609.8 11766.9 11912.3 14818.3 14851.3 14853.5 14861.6 14873.3 7035.5 8436.4 8598.7 8612.0 8698.1 8418.4 8426.6 8535.0 8541.6 8655.0 4497.0 4592.3 4602.7 4616.6 4685.6 1625.9 1781.0 1875.3 1903.5 1918.7 716.9 846.6 922.8 949.1 971.5 20404.0 21877.5 22027.7 22030.8 22133.4 899.7 915.9 917.7 1008.2 1055.6 10408.3 11324.2 11386.1 11529.6 11572.4 613271.0 614456.0 621922.0 628777.0 630841.0 107774.0 129520.4 131680.3 140159.3 140962.3 949.2 954.0 981.2 982.7 983.3 18686.4 19056.2 19160.2 19164.6 19221.5 53064.7 54130.7 54246.7 54493.4 55199.2 80569.9 80693.0 81524.6 84072.0 84473.7 8011.4 8179.2 8217.2 8250.8 8336.3 10636.9 11940.1 12601.8 12681.8 12903.6 10648.8 10879.5 11273.5 11310.7 11444.5 10849.3 11054.1 11171.8 11209.8 11381.7 9554.2 10794.6 11351.0 11375.5 11693.8 8031.9 8067.4 8098.5 8247.5 8309.0 9683.8 10841.2 11041.9 11044.3 11276.8 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5862.06 Median:2712.42 stddev:3339.11 (123.1%) stddev-sans-first:3332.59 13:04:58 INFO - PROCESS | 1656 | Values: 1527.3 1548.9 1763.3 1874.2 1917.2 8771.8 9297.3 9298.2 9300.3 9313.6 8094.6 8361.7 8363.3 8909.3 9114.3 2409.7 2438.7 2443.2 2446.2 2446.3 2013.7 2373.4 2388.0 2433.4 2439.1 1747.9 2204.1 2355.2 2427.8 2429.6 2409.7 2435.6 2436.0 2437.3 2440.1 2403.1 2441.9 2442.5 2443.3 2443.8 9060.0 9149.1 9155.6 9191.7 9238.5 5342.9 5507.1 5507.2 5510.7 5517.6 3399.7 3699.4 3809.3 3828.8 3835.6 1111.1 1133.2 1534.9 1785.9 1892.5 12214.6 12325.1 12339.0 12351.3 12374.0 4584.4 4647.7 4713.8 4760.6 4790.2 9487.5 9491.7 9518.5 9521.5 9521.9 5389.1 5393.3 5393.4 5399.5 5404.5 4929.5 4931.1 5041.9 5044.5 5063.0 3704.0 3718.1 3719.2 3816.7 3824.8 1166.9 1167.6 1172.0 1185.9 1188.4 587.8 758.8 905.6 911.6 942.1 5780.4 5832.3 6014.4 6144.8 6192.9 477.2 492.4 492.9 493.7 610.9 3898.9 3968.9 4043.2 4101.1 4144.5 10755.4 11284.2 11285.3 11309.7 11311.3 11216.5 11219.2 11246.8 11252.6 11253.2 8167.7 8454.2 8572.5 8601.9 8612.2 5836.9 5888.1 5954.3 6090.3 6109.3 10243.4 10356.6 10469.7 10483.2 10511.7 10493.0 10685.8 10721.2 10736.4 10756.8 7099.9 7178.3 7184.6 7186.1 7190.5 8188.7 8360.9 8421.3 8431.5 8526.5 7721.2 7878.3 7919.5 8007.9 8068.2 6357.9 7808.2 7855.3 7893.1 7941.7 7038.6 7108.1 7202.1 7204.0 7204.1 5129.0 5194.7 5320.4 5322.5 5367.0 4610.4 5263.5 5283.9 5364.0 5374.5 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4516.05 Median:4852.31 stddev:1369.44 (28.2%) stddev-sans-first:1335.86 13:04:58 INFO - PROCESS | 1656 | Values: 280.0 302.3 304.5 311.9 315.6 5138.0 5229.3 5362.5 5450.8 5485.5 4051.6 4369.8 4871.8 5202.9 5248.7 3038.6 3617.7 4096.2 4109.0 4202.4 3932.6 4108.2 4118.3 4123.5 4126.3 4108.7 4122.9 4146.9 4171.4 4206.5 4117.2 4117.3 4145.5 4156.4 4170.5 3626.0 3631.0 3632.5 3635.6 3643.8 4276.5 4508.5 4832.9 5302.7 5308.4 4306.2 4582.6 4736.5 4756.3 4759.4 4685.6 5287.3 5612.7 5644.2 5667.8 3849.6 3937.7 3950.4 3971.5 3995.2 5122.3 5695.9 5879.8 5907.3 5911.3 4039.2 4039.5 4040.6 4060.7 4069.6 3542.7 3588.2 4022.1 4120.8 4128.9 4615.9 4700.7 4703.8 4708.6 4711.0 5651.3 5677.5 5710.1 5740.3 5765.3 1261.8 1325.7 1358.2 1391.6 1408.7 767.5 784.0 879.9 889.5 890.4 3913.9 4052.1 4407.9 4493.1 4501.7 4157.8 4461.7 4562.9 4655.5 4922.5 4201.5 5387.2 5388.4 5414.6 5422.7 3031.7 3061.6 3069.2 3070.7 3088.2 5364.3 5694.8 5753.0 5868.7 5924.9 5934.8 5964.3 5967.7 5975.9 5979.6 4603.4 5323.9 6018.8 6021.9 6047.7 5108.3 5346.4 5514.9 5724.5 5791.2 4990.8 5553.8 5732.0 5749.9 5811.9 5605.6 5733.4 5945.8 5997.3 6045.3 3852.0 3869.9 3874.9 3876.7 3878.7 5774.1 5781.4 5799.8 5814.3 5834.4 5358.6 5403.2 5434.7 5648.5 5659.7 4492.7 5173.7 5476.1 5615.3 5622.2 4361.0 4763.8 4787.5 4958.9 5314.9 5371.3 5488.5 5508.2 5650.0 5655.5 4872.3 5210.5 5258.7 5439.5 5535.4 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:26320.10 Median:22525.61 stddev:42687.82 (189.5%) stddev-sans-first:42764.23 13:04:58 INFO - PROCESS | 1656 | Values: 702.4 753.1 781.4 800.1 815.1 15002.8 15249.8 15864.4 15896.2 16203.0 14385.9 14790.8 14797.5 14806.9 14811.0 655.8 670.6 811.1 836.4 840.6 671.9 672.3 674.4 675.6 815.6 729.6 890.7 895.3 897.3 898.1 883.0 885.0 886.0 889.3 889.3 506.5 521.8 651.7 652.0 655.8 14633.4 14935.5 14961.6 14972.9 15540.8 11237.3 13907.0 14374.3 14405.4 14841.4 12400.3 12756.2 12829.2 12948.4 13454.6 4078.0 4585.7 4603.7 4637.7 4800.5 114335.0 118352.4 119064.0 120952.0 122296.6 11004.3 11154.1 11323.9 11350.7 11462.9 18434.9 22490.6 22560.7 22612.5 22725.3 6686.7 7284.6 7914.7 8067.0 8224.7 4175.2 4256.1 4290.9 4334.4 4413.8 3621.7 3696.7 3796.7 3804.0 3805.7 671.4 674.9 677.7 686.1 694.5 490.9 557.5 667.2 678.3 678.5 8589.5 9131.6 9556.4 9607.6 9788.6 562.3 568.6 645.0 652.5 671.3 3649.0 4317.3 4565.6 4573.5 4709.8 90473.5 122699.0 162506.0 166072.2 171226.0 136866.3 140955.0 141612.0 146881.0 148899.0 120341.0 120649.2 121884.6 128074.7 129209.0 8757.1 8848.7 8949.4 8951.3 8961.2 66179.7 67568.7 67651.3 68172.7 71188.9 101798.5 102981.0 103037.5 106681.0 110108.9 11864.8 12052.9 12067.3 12125.8 12520.6 12816.1 13014.2 13404.8 14628.5 14673.7 14006.6 14075.6 14321.1 14713.7 14928.6 13580.3 13766.7 13920.4 14080.6 14183.6 13240.3 13980.7 14062.0 14131.0 14669.9 11131.6 11295.3 11820.1 11993.8 12018.2 11183.9 11527.7 11651.8 11810.5 11992.9 13:04:58 INFO - PROCESS | 1656 | -------- Summary: end -------- 13:04:58 INFO - PROCESS | 1656 | 13:04:58 INFO - TEST-INFO | 1656: exit 0 13:04:58 INFO - TEST-OK | dromaeo_css | took 1117331ms 13:04:58 INFO - TEST-START | kraken 13:04:58 INFO - operating with platform_type : mac_ 13:04:58 INFO - Initialising browser for kraken test... 13:04:58 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp0YZLsP/profile http://localhost:49271/getInfo.html) 13:05:00 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 13:05:00 INFO - PROCESS | 1662 | colorDepth:24 13:05:00 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 13:05:00 INFO - PROCESS | 1662 | __metrics 13:05:01 INFO - PROCESS | 1662 | 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" 13:05:01 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:01 INFO - TEST-INFO | 1662: exit 0 13:05:01 INFO - Browser initialized. 13:05:01 INFO - Running cycle 1/1 for kraken test... 13:05:01 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp0YZLsP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:13 INFO - PROCESS | 1663 | RSS: Main: 219062272 13:05:13 INFO - PROCESS | 1663 | 13:05:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:17 INFO - PROCESS | 1663 | RSS: Main: 268820480 13:05:17 INFO - PROCESS | 1663 | 13:05:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 13:05:20 INFO - PROCESS | 1663 | RSS: Main: 279207936 13:05:20 INFO - PROCESS | 1663 | 13:05:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 13:05:24 INFO - PROCESS | 1663 | RSS: Main: 376008704 13:05:24 INFO - PROCESS | 1663 | 13:05:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 13:05:26 INFO - PROCESS | 1663 | RSS: Main: 278134784 13:05:26 INFO - PROCESS | 1663 | 13:05:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:29 INFO - PROCESS | 1663 | RSS: Main: 279248896 13:05:29 INFO - PROCESS | 1663 | 13:05:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:32 INFO - PROCESS | 1663 | RSS: Main: 317509632 13:05:32 INFO - PROCESS | 1663 | 13:05:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:36 INFO - PROCESS | 1663 | RSS: Main: 319643648 13:05:36 INFO - PROCESS | 1663 | 13:05:39 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 13:05:39 INFO - PROCESS | 1663 | RSS: Main: 317157376 13:05:39 INFO - PROCESS | 1663 | 13:05:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:42 INFO - PROCESS | 1663 | RSS: Main: 289345536 13:05:42 INFO - PROCESS | 1663 | 13:05:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:05:44 INFO - PROCESS | 1663 | RSS: Main: 295796736 13:05:44 INFO - PROCESS | 1663 | 13:05:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:05:47 INFO - PROCESS | 1663 | RSS: Main: 299331584 13:05:47 INFO - PROCESS | 1663 | 13:05:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:05:51 INFO - PROCESS | 1663 | RSS: Main: 312557568 13:05:51 INFO - PROCESS | 1663 | 13:05:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:05:54 INFO - PROCESS | 1663 | RSS: Main: 308559872 13:05:54 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 13:05:56 INFO - PROCESS | 1663 | RSS: Main: 351936512 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | __start_tp_report 13:05:56 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 13:05:56 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 13:05:56 INFO - PROCESS | 1663 | |i|pagename|runs| 13:05:56 INFO - PROCESS | 1663 | |0;ai-astar;117;112;112;113;112;112;113;113;112;114 13:05:56 INFO - PROCESS | 1663 | |1;audio-beat-detection;141;109;107;137;130;111;108;112;175;140 13:05:56 INFO - PROCESS | 1663 | |2;audio-dft;182;185;178;184;182;186;181;185;185;182 13:05:56 INFO - PROCESS | 1663 | |3;audio-fft;80;60;58;85;61;58;61;58;81;57 13:05:56 INFO - PROCESS | 1663 | |4;audio-oscillator;84;70;95;69;67;69;93;68;70;116 13:05:56 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;86;88;87;88;86;89;86;89;87 13:05:56 INFO - PROCESS | 1663 | |6;imaging-darkroom;96;96;97;98;96;97;98;97;97;97 13:05:56 INFO - PROCESS | 1663 | |7;imaging-desaturate;106;145;133;102;86;86;85;86;85;86 13:05:56 INFO - PROCESS | 1663 | |8;json-parse-financial;44;54;52;54;55;56;57;57;57;56 13:05:56 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;72;85;113;107;83;70;69;69;69;69 13:05:56 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;83;79;83;82;84;85;84;85;89;88 13:05:56 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;136;138;136;139;155;125;153;131;185;155 13:05:56 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;194;232;162;164;164;164;164;163;162;162 13:05:56 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;73;87;88;86;87;67;66;66;67 13:05:56 INFO - PROCESS | 1663 | __end_tp_report 13:05:56 INFO - PROCESS | 1663 | __start_cc_report 13:05:56 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1950 13:05:56 INFO - PROCESS | 1663 | __end_cc_report 13:05:56 INFO - PROCESS | 1663 | __startTimestamp1475525156760__endTimestamp 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | ------- Summary: start ------- 13:05:56 INFO - PROCESS | 1663 | Number of tests: 14 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.56 (1.4%) stddev-sans-first:0.73 13:05:56 INFO - PROCESS | 1663 | Values: 117.0 112.0 112.0 113.0 112.0 112.0 113.0 113.0 112.0 114.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:133.50 stddev:21.97 (16.5%) stddev-sans-first:22.71 13:05:56 INFO - PROCESS | 1663 | Values: 141.0 109.0 107.0 137.0 130.0 111.0 108.0 112.0 175.0 140.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:183.00 Median:184.50 stddev:2.45 (1.3%) stddev-sans-first:2.57 13:05:56 INFO - PROCESS | 1663 | Values: 182.0 185.0 178.0 184.0 182.0 186.0 181.0 185.0 185.0 182.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.00 stddev:11.26 (18.5%) stddev-sans-first:10.72 13:05:56 INFO - PROCESS | 1663 | Values: 80.0 60.0 58.0 85.0 61.0 58.0 61.0 58.0 81.0 57.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:70.00 stddev:16.54 (23.6%) stddev-sans-first:17.48 13:05:56 INFO - PROCESS | 1663 | Values: 84.0 70.0 95.0 69.0 67.0 69.0 93.0 68.0 70.0 116.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.17 (1.3%) stddev-sans-first:1.22 13:05:56 INFO - PROCESS | 1663 | Values: 88.0 86.0 88.0 87.0 88.0 86.0 89.0 86.0 89.0 87.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:05:56 INFO - PROCESS | 1663 | Values: 96.0 96.0 97.0 98.0 96.0 97.0 98.0 97.0 97.0 97.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:85.50 stddev:22.08 (25.8%) stddev-sans-first:23.31 13:05:56 INFO - PROCESS | 1663 | Values: 106.0 145.0 133.0 102.0 86.0 86.0 85.0 86.0 85.0 86.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:56.00 stddev:3.94 (7.0%) stddev-sans-first:1.73 13:05:56 INFO - PROCESS | 1663 | Values: 44.0 54.0 52.0 54.0 55.0 56.0 57.0 57.0 57.0 56.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:69.50 stddev:16.65 (24.0%) stddev-sans-first:17.37 13:05:56 INFO - PROCESS | 1663 | Values: 72.0 85.0 113.0 107.0 83.0 70.0 69.0 69.0 69.0 69.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:2.86 (3.4%) stddev-sans-first:3.00 13:05:56 INFO - PROCESS | 1663 | Values: 83.0 79.0 83.0 82.0 84.0 85.0 84.0 85.0 89.0 88.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:146.00 stddev:17.34 (11.9%) stddev-sans-first:18.06 13:05:56 INFO - PROCESS | 1663 | Values: 136.0 138.0 136.0 139.0 155.0 125.0 153.0 131.0 185.0 155.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:164.00 stddev:22.87 (13.9%) stddev-sans-first:22.98 13:05:56 INFO - PROCESS | 1663 | Values: 194.0 232.0 162.0 164.0 164.0 164.0 164.0 163.0 162.0 162.0 13:05:56 INFO - PROCESS | 1663 | 13:05:56 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:79.50 stddev:10.19 (12.8%) stddev-sans-first:10.34 13:05:56 INFO - PROCESS | 1663 | Values: 67.0 73.0 87.0 88.0 86.0 87.0 67.0 66.0 66.0 67.0 13:05:56 INFO - PROCESS | 1663 | -------- Summary: end -------- 13:05:56 INFO - PROCESS | 1663 | 13:05:57 INFO - TEST-INFO | 1663: exit 0 13:05:57 INFO - TEST-OK | kraken | took 58855ms 13:05:57 INFO - SUITE-END | took 1176s 13:05:57 INFO - Completed test suite (00:19:36) 13:05:57 INFO - javascript benchmark 13:05:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2853.2438903690527, 3347.7489188310874, 3370.713489353405, 3407.8807241746545, 3427.2802711430613, 5701.971490142549, 5735.971320143399, 5773.047447171222, 5791.855203619912, 5814.982378083834, 5681.062624666925, 5746.540276777858, 5746.655200687951, 5755.39568345324, 5760.683162426065, 5231.555317797992, 5253.789848406059, 5264.6051546134095, 5290.814821481249, 5306.602004849632, 5218.347706536683, 5239.607029472786, 5325.547328477065, 5328.520433161015, 5345.4387289334645, 5228.137357336035, 5272.894542109156, 5279.076161671711, 5286.735663216843, 5300.151975683892, 5318.361796584415, 5319.521243088141, 5351.438098999627, 5352.437994010612, 5364.141737322048, 5147.330846989905, 5203.245529398254, 5269.815556455544, 5296.629235953485, 5300.814471493479, 5623.887522249573, 5624.072028115397, 5699.886002279973, 5709.800156994527, 5733.713314334266, 6241.3446588108045, 6266.279377871558, 6273.05904114382, 6301.338359472235, 6349.809505714836, 6284.497240220817, 6330.525210609223, 6342.714577844008, 6355.491560675135, 6367.968160159169, 5653.745581448845, 5735.0, 5735.569832262555, 5809.0, 5817.7382017809305, 6290.55966082379, 6316.147320111726, 6317.778877739349, 6320.873582528416, 6334.9366506334345, 6184.226971628546, 6195.256569211723, 6206.875862482725, 6207.968960155261, 6218.347073557302, 6162.291336496271, 6196.752129914843, 6248.812535623939, 6284.025975973731, 6303.495720342362, 6236.875262494725, 6260.342664020303, 6319.399657032574, 6323.810285691345, 6325.272593651697, 6275.529335299871, 6326.145970294044, 6353.5234857385885, 6356.141920840627, 6357.554971152067, 4882.6826256293225, 4907.092187945242, 4917.58200552957, 4997.530667118971, 5020.949790502122, 4425.690201685916, 4466.3747075409465, 4473.015936493966, 4477.2164871147415, 4500.212462819059, 5826.621269617462, 5832.358440571534, 5842.298924129047, 5856.305816051161, 5866.970665146732, 6168.1056246843955, 6312.652804095727, 6314.905276420857, 6324.3991820776955, 6343.55595108338, 5658.7170641467765, 5754.942450575524, 5805.970970145122, 5819.330776960704, 5892.204552385459, 5451.972740136353, 5488.039593071197, 5498.092814685612, 5514.944850551443, 5515.61390702647, 6381.978883378637, 6402.0, 6402.231732192166, 6409.262934762562, 6426.582272152295, 6142.652254521207, 6153.692315384303, 6204.069389591416, 6249.0, 6288.65412402304, 6267.1539342188225, 6300.7479700811455, 6324.0, 6394.808155755335, 6403.551751377545, 6244.968775156095, 6253.062040693932, 6269.592476489013, 6274.1843560336865, 6278.905816412666, 6293.685315734287, 6311.589746666452, 6342.587731797418, 6366.140571022853, 6366.6180029198395, 5991.370906054975, 6044.576879618385, 6100.115483254992, 6140.109684095871, 6151.876962460815, 6179.196704428396, 6183.938160618516, 6204.317525072329, 6211.192544969125, 6211.9068213975925, 6009.158717779427, 6045.727942242522, 6092.390760923872, 6100.450959413674, 6114.57197996136, 5890.676012819336, 5975.133605627247, 6085.361037091042, 6086.695665216633, 6183.103449999815, 5186.2479940407675, 5994.940050599438, 6004.849878753066, 6012.1582978382185, 6054.727537260922], "value": 5751.897490039848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.46113813666835, 512.9051125541775, 519.6596229469694, 524.334095698463, 562.2241306996342, 30211.0, 39961.80019099908, 41158.794206029, 41287.79356103223, 43370.56629433705, 42508.78745606275, 42680.719578412616, 42747.14505709884, 42831.571684283146, 42983.57016429835, 9773.999999999982, 9946.104850563448, 9949.850752238723, 9950.353227040256, 9973.102420782128, 8763.912360876373, 8959.41763785352, 12096.092793040558, 12298.508059677602, 12310.569130080448, 12101.818472722873, 12164.81752773709, 12184.0, 12215.450304736263, 12218.816717749241, 12132.636020919343, 12194.695132621666, 12205.755884882252, 12227.14409991301, 12251.509939602405, 8690.695825646135, 8888.955555222246, 11813.881861181364, 12057.698557536043, 12084.939575302154, 39763.60236397628, 40124.796256112364, 40169.59830401688, 40171.59828401737, 40173.0, 3092.6288845338477, 3281.376538457709, 3359.6640335966454, 3538.876139335111, 3607.1162565171703, 29968.400631987457, 31282.687173128204, 31457.21356966094, 31655.36689266225, 31999.52000719991, 3216.7748257621975, 3221.903342899717, 3271.329377477611, 3287.408266512027, 3308.801471911669, 521534.0, 522677.0, 524284.99999999616, 524946.0, 525015.0, 59926.0, 60282.69858650678, 60354.0, 60470.79058418807, 60576.0, 63844.68077659582, 63855.680721596094, 63862.36137638657, 64057.0, 64088.67955660192, 16113.67772644564, 16507.587310317096, 16535.917320413322, 16543.0, 16547.172641367884, 11559.711007224887, 12819.423125959167, 12888.548900788428, 12896.29070401137, 12897.0, 14656.780148297785, 15168.31742571587, 15515.922420387826, 16360.836391635932, 17188.31246750141, 5984.521238300926, 6045.667488288186, 6112.174856394418, 6117.418845209698, 6147.44672979434, 702.6592102830124, 935.5228833295068, 1033.256055639938, 1048.6539441984128, 1071.8713754349528, 28979.0, 30022.84988575043, 30162.0, 30820.383592328475, 30833.84583077115, 1011.8633984412011, 1026.685842122085, 1082.6643740440488, 1093.2183488805383, 1142.731458107344, 12888.871111288954, 15289.847101528841, 15480.84519154794, 15620.062796232036, 15899.920500397424, 679676.0, 683105.0, 683415.5829220922, 683780.0, 938937.0, 47483.52516474791, 55947.44052559504, 56973.715131424906, 56994.7150264246, 59744.40255597475, 1330.7937269723209, 1344.5764584155959, 1370.7738223193062, 1371.348609410542, 1377.1186440678175, 29781.5532767013, 31023.0, 31050.68949310478, 31189.220269493446, 31733.04800855978, 49293.0, 49617.0, 49691.0, 49834.0, 49848.750756247435, 621509.0, 624750.0, 625848.8707556434, 626018.0, 626301.0, 39152.80423597864, 39613.40579891361, 39929.0, 40032.1993560133, 40186.39720404255, 46334.0, 46391.53608463872, 46874.0, 46920.530794691615, 47068.7646561765, 33772.32455350929, 37668.81165594154, 37760.62239377681, 39745.60254397419, 39926.60073399345, 36199.81900090483, 37870.50877622784, 38270.0, 38925.8053709741, 39560.60439395684, 37366.439503406924, 37712.81143594265, 38367.42448863213, 38687.0, 39738.40392394058, 32553.674463255065, 33903.830480848424, 34552.16269722291, 34765.826170869994, 34902.65097348994, 19717.309894153637, 25596.8720156398, 25768.226953191435, 26061.348466288495, 26107.608385874606], "value": 20538.529126302226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2863615496695, 370.18005118662165, 374.5542804063165, 381.7747528957915, 400.869717341864, 12764.489420423184, 15101.395944162234, 16130.27413766379, 20303.57874948754, 20718.792812071875, 17234.655306893856, 20618.896905515452, 20889.791102088973, 21350.786492135074, 21685.024173912174, 5016.072026675059, 5803.564732645058, 6177.660228687443, 6192.876142477147, 6194.876102477948, 6018.7893423730175, 6077.24034495688, 6086.817395478142, 6120.234970628671, 6173.506119510451, 5721.485066344028, 5906.173135760997, 5966.67183304918, 6005.699715014253, 6024.8493787655225, 6010.939890601082, 6068.059450785136, 6077.301110372297, 6079.392060793907, 6092.817215483543, 5038.974805125988, 5198.116320225571, 5265.76304066318, 5266.736663166865, 5298.390685071189, 19165.520861978563, 23195.76804231953, 23469.06123755048, 25452.745472545408, 25671.358216044562, 2131.5204079082237, 2213.82343262298, 2334.9066037358484, 2340.2862127051244, 2388.868612226327, 9821.558029888673, 9926.45404502752, 10165.135963443116, 10418.635347762793, 13942.860571394258, 1801.5676237702987, 1827.2416946966994, 1842.3183422133895, 1896.7344571759966, 1900.0879577802732, 79240.60379698065, 87030.69453958132, 122179.26818304417, 123654.76345236522, 125019.0, 9293.767655808524, 11570.94214528922, 11609.825852612217, 11766.941165294118, 11912.344821034752, 14818.25908704582, 14851.2574371281, 14853.48012819546, 14861.554153375417, 14873.256337183098, 7035.472339574552, 8436.409451338348, 8598.656053757904, 8611.95694021526, 8698.086700896441, 8418.368622353348, 8426.578671066422, 8535.0, 8541.615627296787, 8655.047944726075, 4496.977515112403, 4592.334111553806, 4602.723836569817, 4616.584507394351, 4685.648576356719, 1625.9431369609613, 1780.9643807123784, 1875.278017963094, 1903.5336342595876, 1918.7121931710356, 716.9211386747454, 846.593635055177, 922.8154369126067, 949.0793929887998, 971.5239532629103, 20404.0, 21877.453063673536, 22027.66958495624, 22030.779692203192, 22133.446663833533, 899.7255836969656, 915.9404638698463, 917.6650522559218, 1008.1732978957331, 1055.5724931402794, 10408.323458975143, 11324.15068869838, 11386.146039047104, 11529.596464123882, 11572.36352000648, 613271.0, 614456.0, 621922.0, 628777.0, 630841.0, 107774.0, 129520.3523982393, 131680.3415982914, 140159.29920350536, 140962.2951885234, 949.1552518258756, 953.952302384878, 981.1954197558076, 982.6560703753629, 983.341161421849, 18686.43940681782, 19056.237750489825, 19160.23359065622, 19164.616707666046, 19221.519462013563, 53064.73467632637, 54130.729346353015, 54246.72876635592, 54493.36806371503, 55199.17201242065, 80569.90435241458, 80693.0, 81524.59237703774, 84072.0, 84473.73289400787, 8011.399145064027, 8179.222973817477, 8217.178282171735, 8250.752477425447, 8336.29141522953, 10636.946815265874, 11940.10449216295, 12601.810972835232, 12681.80977285323, 12903.612891613267, 10648.84026739584, 10879.51042203087, 11273.549058037586, 11310.717232069264, 11444.542218311175, 10849.294795838245, 11054.115670746482, 11171.832422513831, 11209.831852522055, 11381.658550243506, 9554.235661146953, 10794.56821727122, 11351.0, 11375.488103035217, 11693.76612467763, 8031.919680803117, 8067.435279530377, 8098.473599216032, 8247.546384948886, 8308.958455207685, 9683.806323873623, 10841.241113122005, 11041.889581104408, 11044.282121662067, 11276.830847537458], "value": 9508.451555676755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.25164669312, 1548.8683461905737, 1763.2682436788734, 1874.1940965384879, 1917.1660327757418, 8771.780705482359, 9297.349185557014, 9298.16316531512, 9300.255979521638, 9313.627454901813, 8094.635741391637, 8361.749147525568, 8363.289120424772, 8909.287257019423, 9114.31642626804, 2409.722881868581, 2438.6585877977095, 2443.2059580636273, 2446.217210492643, 2446.2538925627678, 2013.6778115501522, 2373.4303767095857, 2387.9761202388013, 2433.415980164765, 2439.0975339124548, 1747.9038652874087, 2204.0522575292616, 2355.199232261031, 2427.8421902576365, 2429.5505331513637, 2409.650600662903, 2435.5981263091567, 2435.987820060906, 2437.2810021043747, 2440.060576677992, 2403.098837935774, 2441.9389515262083, 2442.5481285962155, 2443.2914454808083, 2443.8289319747623, 9059.954700226523, 9149.130832570962, 9155.587998540082, 9191.678291259774, 9238.538073096319, 5342.893142137135, 5507.091329930557, 5507.201455788928, 5510.6969116698565, 5517.613767036309, 3399.6940275375337, 3699.408094704834, 3809.3143234218105, 3828.7894165820867, 3835.5972622874474, 1111.0778054215064, 1133.167122165208, 1534.8695360894337, 1785.9017754023523, 1892.5268682829292, 12214.572489962897, 12325.075619328587, 12338.99999999991, 12351.32067736274, 12374.0, 4584.381108550303, 4647.744374059459, 4713.835015774432, 4760.64295177863, 4790.209615413488, 9487.525623718786, 9491.715248542554, 9518.524073796283, 9521.523923803783, 9521.904780952102, 5389.110796718576, 5393.325834270716, 5393.352797664227, 5399.514043736004, 5404.486573775485, 4929.482404347564, 4931.112399768076, 5041.924371134436, 5044.495550445, 5063.012712521097, 3704.0, 3718.1262403335195, 3719.20037192005, 3816.656500914931, 3824.827882745283, 1166.877477864829, 1167.5563285951284, 1171.9589814356457, 1185.946632401544, 1188.4236145469613, 587.7795826565039, 758.8406434648675, 905.5924833824805, 911.589784596934, 942.137943781446, 5780.393058728773, 5832.270966129234, 6014.368491308437, 6144.846378840565, 6192.938070619236, 477.17925168709763, 492.4091090691185, 492.85214435669155, 493.71858040916334, 610.8790369671614, 3898.922021559553, 3968.920621587552, 4043.1913617276664, 4101.077257617012, 4144.52337981136, 10755.354678719303, 11284.21010529255, 11285.266457680225, 11309.717257068474, 11311.321320720783, 11216.495257713423, 11219.1585631078, 11246.775064498665, 11252.606158784567, 11253.156013299036, 8167.71413000554, 8454.15458454162, 8572.485650860968, 8601.913980860236, 8612.181842725056, 5836.854078647898, 5888.116782482491, 5954.3152537458745, 6090.299615544269, 6109.266887973472, 10243.43661098617, 10356.637517686844, 10469.738256543647, 10483.161347092368, 10511.684649460529, 10493.003164699647, 10685.839712404475, 10721.195910306915, 10736.355818650905, 10756.83864742045, 7099.858002840017, 7178.318059784312, 7184.568925864465, 7186.10173728284, 7190.532615379983, 8188.713395031145, 8360.916390836013, 8421.284190843848, 8431.451955622864, 8526.488410695378, 7721.150673425806, 7878.290953814184, 7919.485233459806, 8007.879881801894, 8068.193180681885, 6357.8728425432155, 7808.180141085104, 7855.332296754611, 7893.092294386219, 7941.722039728582, 7038.648067596702, 7108.111486064242, 7202.135743710788, 7204.027456293543, 7204.063471748639, 5129.0, 5194.714290714047, 5320.44135365781, 5322.520973112439, 5367.0, 4610.377599024089, 5263.499967503081, 5283.86396924663, 5363.988489380669, 5374.516293533601], "value": 4634.790007461704, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.99860000699994, 302.26851020530313, 304.49301912315997, 311.8658976640045, 315.5723993988146, 5138.023775482656, 5229.294045303883, 5362.544183744377, 5450.754716037778, 5485.478879506445, 4051.615096565829, 4369.759663218521, 4871.757701786039, 5202.921956170651, 5248.737563121847, 3038.6049813524264, 3617.656322649344, 4096.221717873609, 4109.027666719976, 4202.411662367271, 3932.6460618544324, 4108.178364327132, 4118.341065429532, 4123.525794533622, 4126.31915733905, 4108.712390132692, 4122.917541649165, 4146.937795933063, 4171.416001759756, 4206.548740684474, 4117.17656468706, 4117.341225403936, 4145.481814773153, 4156.43888075109, 4170.4995400551825, 3626.0, 3631.0, 3632.4914511968345, 3635.563732352108, 3643.7813731175947, 4276.5295817460055, 4508.481524624677, 4832.85501434954, 5302.708351040691, 5308.442613525563, 4306.246406878815, 4582.6104781093645, 4736.478987311393, 4756.262779269219, 4759.357486739281, 4685.601723853477, 5287.286216360781, 5612.719364031782, 5644.181593668936, 5667.829965101054, 3849.615038496156, 3937.7046721496004, 3950.392740791064, 3971.543272523639, 3995.1610161866042, 5122.308488354061, 5695.917775622618, 5879.764809407661, 5907.274180655501, 5911.290645122613, 4039.1719697462536, 4039.5152581690386, 4040.5555388907196, 4060.7360521566, 4069.552349241581, 3542.6634469725336, 3588.205897051474, 4022.0950286185375, 4120.814563344657, 4128.876133715993, 4615.869112067565, 4700.741459219707, 4703.7883295251795, 4708.587423772855, 4710.9764451177525, 5651.321841379061, 5677.545796336283, 5710.087855193798, 5740.253767010262, 5765.281393501168, 1261.7791886420023, 1325.681836359286, 1358.213948657532, 1391.5616580777225, 1408.6688079764729, 767.5049593012476, 783.9725609603637, 879.907609700985, 889.4929889962789, 890.425675439338, 3913.9021524462114, 4052.1085361220485, 4407.933880991788, 4493.056458143761, 4501.68488205829, 4157.771322577227, 4461.665375096881, 4562.931556026662, 4655.462772788838, 4922.505021434821, 4201.474815648044, 5387.218853266255, 5388.407275199725, 5414.593905457106, 5422.674639521641, 3031.7262053459904, 3061.632604087479, 3069.202007478027, 3070.650952021705, 3088.2279430142466, 5364.302640656768, 5694.800681976111, 5752.971235143881, 5868.706564671749, 5924.881502369928, 5934.7922822701, 5964.284285885721, 5967.671778052162, 5975.850603734854, 5979.5814292999075, 4603.401557797465, 5323.893522129536, 6018.789342372996, 6021.862238905301, 6047.7278522466595, 5108.3103780989095, 5346.411894691659, 5514.889702206014, 5724.542036636975, 5791.160281759037, 4990.777259571283, 5553.805616803393, 5731.971340143273, 5749.942500574941, 5811.912821307599, 5605.579581531483, 5733.426657334233, 5945.781114871527, 5997.340292567901, 6045.274567051982, 3851.980740096282, 3869.864554740683, 3874.8837534874, 3876.6511014008875, 3878.670313023312, 5774.133879918046, 5781.364049954417, 5799.797007104731, 5814.273215848019, 5834.445727655866, 5358.598105142052, 5403.216533602685, 5434.717418684241, 5648.5481161507805, 5659.717014149193, 4492.663050271308, 5173.663711858717, 5476.123820188751, 5615.2700148980375, 5622.240997465454, 4361.037533110177, 4763.809447622057, 4787.521247875324, 4958.851234462972, 5314.910443359025, 5371.328583927009, 5488.506034456918, 5508.228847961369, 5649.971750141223, 5655.462731040545, 4872.294696856214, 5210.515003224063, 5258.6581872178185, 5439.456054394529, 5535.446455354593], "value": 4077.3097457623226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.3573430311263, 753.1376573822973, 781.3631890009646, 800.1318569352253, 815.0748899998501, 15002.849971500282, 15249.771253431207, 15864.365425382985, 15896.205189740496, 16203.027818330878, 14385.92807035966, 14790.778138327934, 14797.482088126917, 14806.851931480682, 14811.0, 655.8130932684186, 670.580886945659, 811.0591713612225, 836.4145098431092, 840.6301227459928, 671.8824205763996, 672.2907332763932, 674.430106559956, 675.598019178588, 815.559597817178, 729.5513259345491, 890.6971629645919, 895.2703546609492, 897.3135551303258, 898.0704970355683, 882.9690960816405, 885.0441523155041, 886.0165216609558, 889.2885691446849, 889.3285569395065, 506.541579870218, 521.7912834866046, 651.690447037658, 651.9804405867784, 655.7934250711058, 14633.41466341345, 14935.477258295907, 14961.551153465305, 14972.925135374253, 15540.844591554052, 11237.3257604544, 13907.0, 14374.281285935662, 14405.423783048665, 14841.406343746237, 12400.255984640951, 12756.170848894792, 12829.23024618526, 12948.352582370939, 13454.596362109152, 4077.9592204077876, 4585.70192937458, 4603.700759450625, 4637.652176086807, 4800.495947925452, 114335.0, 118352.40823795913, 119064.0, 120952.0, 122296.55406891901, 11004.284721493077, 11154.10767138627, 11323.943380283046, 11350.716232094264, 11462.885371146349, 18434.90782546079, 22490.550188996454, 22560.66159007616, 22612.547749044927, 22725.318240452812, 6686.69609426167, 7284.562926224444, 7914.722984695508, 8067.031956165298, 8224.712135075244, 4175.206710724952, 4256.1487702459635, 4290.914181716348, 4334.371516130143, 4413.845515406945, 3621.7464777465852, 3696.6857817085847, 3796.6962642988497, 3803.9619603804163, 3805.7145714071557, 671.4359937652298, 674.8953912143626, 677.6747161362475, 686.114911763829, 694.482610455204, 490.8920037591724, 557.4759725857681, 667.2360147630935, 678.2945736434152, 678.4835891781863, 8589.484630922165, 9131.589078491485, 9556.378835375679, 9607.615695372107, 9788.55951482185, 562.3224015061923, 568.5536853569928, 644.9709763060673, 652.5236577298599, 671.3051991189096, 3648.9635103648625, 4317.287647538184, 4565.6119229865835, 4573.519780423074, 4709.764511774398, 90473.54763226141, 122699.0, 162506.0, 166072.16963915102, 171226.0, 136866.315668421, 140955.0, 141612.0, 146881.0, 148899.0, 120341.0, 120649.1902621479, 121884.56961325706, 128074.71925280814, 129209.0, 8757.09313573934, 8848.734537963872, 8949.373543851867, 8951.283897288331, 8961.23829474502, 66179.66910165419, 67568.66215668891, 67651.32348676647, 68172.65913670599, 71188.93216601858, 101798.4910075445, 102981.0, 103037.48481257545, 106681.0, 110108.89891100986, 11864.822027669765, 12052.939735301268, 12067.275963442222, 12125.81811272814, 12520.561780337644, 12816.102872798814, 13014.21914685122, 13404.798928015893, 14628.488002919847, 14673.706525869637, 14006.649833754238, 14075.648108797363, 14321.069130506483, 14713.705725885207, 14928.552143435714, 13580.25308608036, 13766.692164244381, 13920.443182273, 14080.577582672537, 14183.574492765234, 13240.337983100999, 13980.650483737987, 14062.0, 14131.0, 14669.853301466848, 11131.610393636183, 11295.322280663186, 11820.113491488344, 11993.790463069756, 12018.158728888893, 11183.88816111861, 11527.711807204552, 11651.766964660828, 11810.527578896748, 11992.940035299767], "value": 7897.32552786733, "unit": "score"}], "name": "dromaeo_css", "value": 7425.689437445709, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 107.0, 137.0, 130.0, 111.0, 108.0, 112.0, 175.0, 140.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 178.0, 184.0, 182.0, 186.0, 181.0, 185.0, 185.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 85.0, 61.0, 58.0, 61.0, 58.0, 81.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 69.0, 67.0, 69.0, 93.0, 68.0, 70.0, 116.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 87.0, 88.0, 86.0, 89.0, 86.0, 89.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 98.0, 96.0, 97.0, 98.0, 97.0, 97.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 145.0, 133.0, 102.0, 86.0, 86.0, 85.0, 86.0, 85.0, 86.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 54.0, 52.0, 54.0, 55.0, 56.0, 57.0, 57.0, 57.0, 56.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 85.0, 113.0, 107.0, 83.0, 70.0, 69.0, 69.0, 69.0, 69.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 83.0, 82.0, 84.0, 85.0, 84.0, 85.0, 89.0, 88.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 136.0, 139.0, 155.0, 125.0, 153.0, 131.0, 185.0, 155.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 232.0, 162.0, 164.0, 164.0, 164.0, 164.0, 163.0, 162.0, 162.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 87.0, 88.0, 86.0, 87.0, 67.0, 66.0, 66.0, 67.0], "value": 75.4, "unit": "score"}], "name": "kraken", "value": 1466.1, "alertThreshold": 2.0}]} 13:05:57 INFO - Return code: 0 13:05:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:05:58 INFO - # TBPL SUCCESS # 13:05:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:05:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:05:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:05:58 INFO - 2016-10-03 13:05:58.079 screenresolution[1667:10621] starting screenresolution argv=screenresolution get 13:05:58 INFO - 2016-10-03 13:05:58.081 screenresolution[1667:10621] Display 0: 1600x1200x32@60 13:05:58 INFO - 2016-10-03 13:05:58.087 screenresolution[1668:10624] starting screenresolution argv=screenresolution list 13:05:58 INFO - Available Modes on Display 0 13:05:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:05:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:05:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:05:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:05:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:05:58 INFO - Intel Iris: 13:05:58 INFO - Chipset Model: Intel Iris 13:05:58 INFO - Type: GPU 13:05:58 INFO - Bus: Built-In 13:05:58 INFO - VRAM (Dynamic, Max): 1536 MB 13:05:58 INFO - Vendor: Intel (0x8086) 13:05:58 INFO - Device ID: 0x0a2e 13:05:58 INFO - Revision ID: 0x0009 13:05:58 INFO - Displays: 13:05:58 INFO - Display: 13:05:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:05:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:05:58 INFO - Display Serial Number: 1600x1200 60 13:05:58 INFO - Main Display: Yes 13:05:58 INFO - Mirror: Off 13:05:58 INFO - Online: Yes 13:05:58 INFO - Rotation: Supported 13:05:58 INFO - Return code: 0 13:05:58 INFO - Running post-action listener: _resource_record_post_action 13:05:58 INFO - [mozharness: 2016-10-03 20:05:58.324766Z] Finished run-tests step (success) 13:05:58 INFO - Running post-run listener: _resource_record_post_run 13:05:58 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32087040; Write bytes: 662531584; Read time: 194; Write time: 1869 13:05:58 INFO - TinderboxPrint: CPU usage
53.3% 13:05:58 INFO - TinderboxPrint: I/O read bytes / time
32,087,040 / 194 13:05:58 INFO - TinderboxPrint: I/O write bytes / time
662,531,584 / 1,869 13:05:58 INFO - TinderboxPrint: CPU idle
2,260.4 (46.7%) 13:05:58 INFO - TinderboxPrint: CPU system
965.2 (20.0%) 13:05:58 INFO - TinderboxPrint: CPU user
1,612.0 (33.3%) 13:05:58 INFO - TinderboxPrint: Swap in / out
391,774,208 / 0 13:05:58 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358126080; Write bytes: 355677696; Read time: 27515; Write time: 734 13:05:58 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30219264; Write bytes: 295835648; Read time: 179; Write time: 1098 13:05:58 INFO - Running post-run listener: _upload_blobber_files 13:05:58 INFO - Blob upload gear active. 13:05:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:05:58 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 13:05:58 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'] 13:05:58 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 13:05:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:05:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:05:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:05:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:06:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:00 INFO - (blobuploader) - INFO - Done attempting. 13:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:06:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:01 INFO - (blobuploader) - INFO - Done attempting. 13:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:06:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:04 INFO - (blobuploader) - INFO - Done attempting. 13:06:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:06:04 INFO - Return code: 0 13:06:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:06:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:06:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd74f75b53c76bfec673e47fb3ed148e81b5d87367fe0a18fd47698ab5bbc0875e59d086a460a2ab24aea2515360c48b9969dc8abf388d45a0368ae4a16fd20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0b91b933abfa2dc0846c86407af941306fabd3c2f9144ef13fb3ad27090bed686a61dfe087f015e68bee435ea92663e13059e791c0fd3509c4f430d8855dbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01a39f696bc529c5c884aa624e49153b7cf055599427e21abf454f7f056760ad78e94e661dbd485b49fe44b03ced07d8d357148100dc10ad49258ff45706e47"} 13:06:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:06:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:06:04 INFO - Contents: 13:06:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd74f75b53c76bfec673e47fb3ed148e81b5d87367fe0a18fd47698ab5bbc0875e59d086a460a2ab24aea2515360c48b9969dc8abf388d45a0368ae4a16fd20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0b91b933abfa2dc0846c86407af941306fabd3c2f9144ef13fb3ad27090bed686a61dfe087f015e68bee435ea92663e13059e791c0fd3509c4f430d8855dbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01a39f696bc529c5c884aa624e49153b7cf055599427e21abf454f7f056760ad78e94e661dbd485b49fe44b03ced07d8d357148100dc10ad49258ff45706e47"} 13:06:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:06:04 INFO - Copying logs to upload dir... 13:06:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:06:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.792446 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-03 13:06:04.291113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:06:04.298272) ========= 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.JzLPKSNv75/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.AcmjpixyUz/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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/bd74f75b53c76bfec673e47fb3ed148e81b5d87367fe0a18fd47698ab5bbc0875e59d086a460a2ab24aea2515360c48b9969dc8abf388d45a0368ae4a16fd20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0b91b933abfa2dc0846c86407af941306fabd3c2f9144ef13fb3ad27090bed686a61dfe087f015e68bee435ea92663e13059e791c0fd3509c4f430d8855dbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01a39f696bc529c5c884aa624e49153b7cf055599427e21abf454f7f056760ad78e94e661dbd485b49fe44b03ced07d8d357148100dc10ad49258ff45706e47"} build_url:https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/IzDaMAa0Re2Rf-Xtl7lMdQ/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/bd74f75b53c76bfec673e47fb3ed148e81b5d87367fe0a18fd47698ab5bbc0875e59d086a460a2ab24aea2515360c48b9969dc8abf388d45a0368ae4a16fd20c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0b91b933abfa2dc0846c86407af941306fabd3c2f9144ef13fb3ad27090bed686a61dfe087f015e68bee435ea92663e13059e791c0fd3509c4f430d8855dbd0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01a39f696bc529c5c884aa624e49153b7cf055599427e21abf454f7f056760ad78e94e661dbd485b49fe44b03ced07d8d357148100dc10ad49258ff45706e47"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 13:06:04.333800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:06:04.334149) ========= 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.JzLPKSNv75/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.AcmjpixyUz/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.005158 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 13:06:04.382617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:06:04.385982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 13:06:04.386323) ========= ========= Total master_lag: 0.21 =========