builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1479135279.84 results: success (0) buildid: 20161114015620 builduid: 7575ab475a3f4481a1ee0dc2e232252d revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.835792) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.836227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.836498) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.886224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.886479) ========= 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.3mZIPqYIus/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.2nkPsVoh8b/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 06:54:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2016-11-14 06:54:40 (21.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.595450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:40.503288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:40.503586) ========= 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.3mZIPqYIus/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.2nkPsVoh8b/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.020676 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:40.552242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:54:40.552599) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --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 0f867a8846778f927cfb3871e58cc61f6193ad5d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3mZIPqYIus/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.2nkPsVoh8b/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 06:54:40,633 truncating revision to first 12 chars 2016-11-14 06:54:40,633 Setting DEBUG logging. 2016-11-14 06:54:40,634 attempt 1/10 2016-11-14 06:54:40,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f867a884677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 06:54:42,179 unpacking tar archive at: mozilla-aurora-0f867a884677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.794417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:54:42.371795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.372136) ========= script_repo_revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.372527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.372797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.391104) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 06:54:42.391463) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3mZIPqYIus/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.2nkPsVoh8b/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:54:42 INFO - MultiFileLogger online at 20161114 06:54:42 in /builds/slave/test 06:54:42 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 06:54:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:42 INFO - {'append_to_log': False, 06:54:42 INFO - 'base_work_dir': '/builds/slave/test', 06:54:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:54:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:42 INFO - 'branch': 'Mozilla-Aurora', 06:54:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:42 INFO - 'config_files': ('talos/mac_config.py',), 06:54:42 INFO - 'default_actions': ('clobber', 06:54:42 INFO - 'read-buildbot-config', 06:54:42 INFO - 'download-and-extract', 06:54:42 INFO - 'populate-webroot', 06:54:42 INFO - 'create-virtualenv', 06:54:42 INFO - 'install', 06:54:42 INFO - 'run-tests'), 06:54:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:42 INFO - 'download_minidump_stackwalk': True, 06:54:42 INFO - 'download_symbols': 'ondemand', 06:54:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:42 INFO - 'installer_path': 'installer.exe', 06:54:42 INFO - 'log_level': 'info', 06:54:42 INFO - 'log_name': 'talos', 06:54:42 INFO - 'log_to_console': True, 06:54:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:42 INFO - 'opt_config_files': (), 06:54:42 INFO - 'pip_index': False, 06:54:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:42 INFO - 'cmd': ('bash', 06:54:42 INFO - '-c', 06:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:42 INFO - 'enabled': True, 06:54:42 INFO - 'halt_on_failure': False, 06:54:42 INFO - 'name': 'check_screen_resolution'},), 06:54:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:42 INFO - 'cmd': ('bash', 06:54:42 INFO - '-c', 06:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:42 INFO - 'enabled': True, 06:54:42 INFO - 'halt_on_failure': False, 06:54:42 INFO - 'name': 'check_screen_resolution'},), 06:54:42 INFO - 'run_cmd_checks_enabled': True, 06:54:42 INFO - 'sps_profile': False, 06:54:42 INFO - 'sps_profile_interval': 0, 06:54:42 INFO - 'suite': 'dromaeojs', 06:54:42 INFO - 'system_bits': '32', 06:54:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:42 INFO - 'title': 't-yosemite-r7-0143', 06:54:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:42 INFO - 'use_talos_json': True, 06:54:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:42 INFO - 'work_dir': 'build'} 06:54:42 INFO - [mozharness: 2016-11-14 14:54:42.588925Z] Running clobber step. 06:54:42 INFO - Running pre-action listener: _resource_record_pre_action 06:54:42 INFO - Running main action method: clobber 06:54:42 INFO - rmtree: /builds/slave/test/build 06:54:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:44 INFO - Running post-action listener: _resource_record_post_action 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.830442Z] Finished clobber step (success) 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.830564Z] Running read-buildbot-config step. 06:54:44 INFO - Running pre-action listener: _resource_record_pre_action 06:54:44 INFO - Running main action method: read_buildbot_config 06:54:44 INFO - Using buildbot properties: 06:54:44 INFO - { 06:54:44 INFO - "project": "", 06:54:44 INFO - "product": "firefox", 06:54:44 INFO - "script_repo_revision": "production", 06:54:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:54:44 INFO - "repository": "", 06:54:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:54:44 INFO - "buildid": "20161114015620", 06:54:44 INFO - "pgo_build": "False", 06:54:44 INFO - "basedir": "/builds/slave/test", 06:54:44 INFO - "buildnumber": 33, 06:54:44 INFO - "slavename": "t-yosemite-r7-0143", 06:54:44 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:54:44 INFO - "platform": "yosemite_r7", 06:54:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:54:44 INFO - "branch": "mozilla-aurora", 06:54:44 INFO - "repo_path": "releases/mozilla-aurora", 06:54:44 INFO - "revision": "0f867a8846778f927cfb3871e58cc61f6193ad5d", 06:54:44 INFO - "stage_platform": "macosx64", 06:54:44 INFO - "builduid": "7575ab475a3f4481a1ee0dc2e232252d", 06:54:44 INFO - "slavebuilddir": "test" 06:54:44 INFO - } 06:54:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:54:44 INFO - Running post-action listener: _resource_record_post_action 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.833833Z] Finished read-buildbot-config step (success) 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.833945Z] Running download-and-extract step. 06:54:44 INFO - Running pre-action listener: _resource_record_pre_action 06:54:44 INFO - Running main action method: download_and_extract 06:54:44 INFO - mkdir: /builds/slave/test/build/tests 06:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:44 INFO - trying https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:54:44 INFO - Downloading https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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 06:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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 06:54:46 INFO - Downloaded 1199 bytes. 06:54:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:54:46 INFO - Using the following test package requirements: 06:54:46 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:54:46 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:54:46 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:54:46 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'jsshell-mac.zip'], 06:54:46 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:54:46 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:54:46 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:54:46 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:54:46 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:54:46 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:54:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:54:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:54:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:54:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:54:46 INFO - Expected file size: 16423758 06:54:53 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 06:54:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:54:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:54:53 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:54:54 INFO - Expected file size: 16423758 06:55:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 06:55:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:55:01 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 06:55:02 INFO - Expected file size: 14414089 06:55:02 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')]} 06:55:02 INFO - trying https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 06:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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 06:55:05 INFO - Downloaded 115545916 bytes. 06:55:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:55:05 INFO - mkdir: /builds/slave/test/properties 06:55:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:05 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:05 INFO - Contents: 06:55:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:55:06 INFO - Running post-action listener: _resource_record_post_action 06:55:06 INFO - Running post-action listener: set_extra_try_arguments 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.600170Z] Finished download-and-extract step (success) 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.600280Z] Running populate-webroot step. 06:55:06 INFO - Running pre-action listener: _resource_record_pre_action 06:55:06 INFO - Running main action method: populate_webroot 06:55:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:06 INFO - '--tppagecycles', 06:55:06 INFO - '7'], 06:55:06 INFO - 'tests': ['tsvgm']}}, 06:55:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['damp', 'tps']}, 06:55:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'tests': ['damp', 'tps']}, 06:55:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['dromaeo_dom']}, 06:55:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['basic_compositor_video']}, 06:55:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:55:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tsvgx', 06:55:06 INFO - 'tsvgr_opacity', 06:55:06 INFO - 'tart', 06:55:06 INFO - 'tscrollx', 06:55:06 INFO - 'cart']}, 06:55:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:06 INFO - 'tsvgr_opacity', 06:55:06 INFO - 'tart', 06:55:06 INFO - 'tscrollx', 06:55:06 INFO - 'cart']}, 06:55:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tp5o']}, 06:55:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'tests': ['tp5o']}, 06:55:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s', 06:55:06 INFO - '--xperf_path', 06:55:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:06 INFO - 'tests': ['tp5n']}, 06:55:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--xperf_path', 06:55:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:06 INFO - 'tests': ['tp5n']}}, 06:55:06 INFO - 'talos.zip': {'path': '', 06:55:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:06 INFO - Running post-action listener: _resource_record_post_action 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.619214Z] Finished populate-webroot step (success) 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.619352Z] Running create-virtualenv step. 06:55:06 INFO - Running pre-action listener: _resource_record_pre_action 06:55:06 INFO - Running main action method: create_virtualenv 06:55:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:06 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 06:55:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:06 INFO - Using real prefix '/tools/python27' 06:55:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:10 INFO - Installing pip.................done. 06:55:10 INFO - Return code: 0 06:55:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55:10 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')]} 06:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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')]} 06:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:10 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 06:55:10 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 06:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:10 INFO - 'HOME': '/Users/cltbld', 06:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:10 INFO - 'LOGNAME': 'cltbld', 06:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:10 INFO - 'MOZ_NO_REMOTE': '1', 06:55:10 INFO - 'NO_EM_RESTART': '1', 06:55:10 INFO - 'PAGER': '/bin/cat', 06:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:10 INFO - 'PWD': '/builds/slave/test', 06:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:10 INFO - 'SHELL': '/bin/bash', 06:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:10 INFO - 'USER': 'cltbld', 06:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:10 INFO - 'XPC_FLAGS': '0x0', 06:55:10 INFO - 'XPC_SERVICE_NAME': '0', 06:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:10 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 06:55:10 INFO - Cleaning up... 06:55:10 INFO - Return code: 0 06:55:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:55:10 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')]} 06:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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')]} 06:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:10 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 06:55:10 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 06:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:10 INFO - 'HOME': '/Users/cltbld', 06:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:10 INFO - 'LOGNAME': 'cltbld', 06:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:10 INFO - 'MOZ_NO_REMOTE': '1', 06:55:10 INFO - 'NO_EM_RESTART': '1', 06:55:10 INFO - 'PAGER': '/bin/cat', 06:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:10 INFO - 'PWD': '/builds/slave/test', 06:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:10 INFO - 'SHELL': '/bin/bash', 06:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:10 INFO - 'USER': 'cltbld', 06:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:10 INFO - 'XPC_FLAGS': '0x0', 06:55:10 INFO - 'XPC_SERVICE_NAME': '0', 06:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:10 INFO - Downloading/unpacking psutil>=3.1.1 06:55:10 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 06:55:10 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 06:55:10 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 06:55:10 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 06:55:10 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 06:55:10 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 06:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:14 INFO - Installing collected packages: psutil 06:55:14 INFO - Running setup.py install for psutil 06:55:14 INFO - building 'psutil._psutil_osx' extension 06:55:14 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 06:55:14 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 06:55:14 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 06:55:14 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 06:55:14 INFO - building 'psutil._psutil_posix' extension 06:55:14 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 06:55:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:55:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:55:14 INFO - ^ 06:55:15 INFO - 1 warning generated. 06:55:15 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 06:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:15 INFO - Successfully installed psutil 06:55:15 INFO - Cleaning up... 06:55:15 INFO - Return code: 0 06:55:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:55:15 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')]} 06:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:15 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')]} 06:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:15 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:15 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 06:55:15 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 06:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:15 INFO - 'HOME': '/Users/cltbld', 06:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:15 INFO - 'LOGNAME': 'cltbld', 06:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:15 INFO - 'MOZ_NO_REMOTE': '1', 06:55:15 INFO - 'NO_EM_RESTART': '1', 06:55:15 INFO - 'PAGER': '/bin/cat', 06:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:15 INFO - 'PWD': '/builds/slave/test', 06:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:15 INFO - 'SHELL': '/bin/bash', 06:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:15 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:15 INFO - 'USER': 'cltbld', 06:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:15 INFO - 'XPC_FLAGS': '0x0', 06:55:15 INFO - 'XPC_SERVICE_NAME': '0', 06:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:55:18 INFO - Installing collected packages: mozsystemmonitor 06:55:18 INFO - Running setup.py install for mozsystemmonitor 06:55:18 INFO - Successfully installed mozsystemmonitor 06:55:18 INFO - Cleaning up... 06:55:18 INFO - Return code: 0 06:55:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:55:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:18 INFO - 'HOME': '/Users/cltbld', 06:55:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:18 INFO - 'LOGNAME': 'cltbld', 06:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:18 INFO - 'MOZ_NO_REMOTE': '1', 06:55:18 INFO - 'NO_EM_RESTART': '1', 06:55:18 INFO - 'PAGER': '/bin/cat', 06:55:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:18 INFO - 'PWD': '/builds/slave/test', 06:55:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:18 INFO - 'SHELL': '/bin/bash', 06:55:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:18 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:18 INFO - 'USER': 'cltbld', 06:55:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:18 INFO - 'XPC_FLAGS': '0x0', 06:55:18 INFO - 'XPC_SERVICE_NAME': '0', 06:55:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:18 INFO - Downloading/unpacking jsonschema==2.5.1 06:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:55:20 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 06:55:20 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 06:55:20 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 06:55:20 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 06:55:20 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 06:55:20 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 06:55:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:21 INFO - warning: no files found matching '*.txt' 06:55:21 INFO - no previously-included directories found matching 'build' 06:55:21 INFO - no previously-included directories found matching 'dist' 06:55:21 INFO - no previously-included directories found matching '.git*' 06:55:21 INFO - Installing collected packages: jsonschema, functools32 06:55:21 INFO - Running setup.py install for functools32 06:55:21 INFO - warning: no files found matching '*.txt' 06:55:21 INFO - no previously-included directories found matching 'build' 06:55:21 INFO - no previously-included directories found matching 'dist' 06:55:21 INFO - no previously-included directories found matching '.git*' 06:55:21 INFO - Successfully installed jsonschema functools32 06:55:21 INFO - Cleaning up... 06:55:21 INFO - Return code: 0 06:55:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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', '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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:55: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 functools32==3.2.3-2 06:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:21 INFO - 'HOME': '/Users/cltbld', 06:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:21 INFO - 'LOGNAME': 'cltbld', 06:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:21 INFO - 'MOZ_NO_REMOTE': '1', 06:55:21 INFO - 'NO_EM_RESTART': '1', 06:55:21 INFO - 'PAGER': '/bin/cat', 06:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:21 INFO - 'PWD': '/builds/slave/test', 06:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:21 INFO - 'SHELL': '/bin/bash', 06:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:21 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:21 INFO - 'USER': 'cltbld', 06:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:21 INFO - 'XPC_FLAGS': '0x0', 06:55:21 INFO - 'XPC_SERVICE_NAME': '0', 06:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:55:22 INFO - Cleaning up... 06:55:22 INFO - Return code: 0 06:55:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:22 INFO - 'HOME': '/Users/cltbld', 06:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:22 INFO - 'LOGNAME': 'cltbld', 06:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:22 INFO - 'MOZ_NO_REMOTE': '1', 06:55:22 INFO - 'NO_EM_RESTART': '1', 06:55:22 INFO - 'PAGER': '/bin/cat', 06:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:22 INFO - 'PWD': '/builds/slave/test', 06:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:22 INFO - 'SHELL': '/bin/bash', 06:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:22 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:22 INFO - 'USER': 'cltbld', 06:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:22 INFO - 'XPC_FLAGS': '0x0', 06:55:22 INFO - 'XPC_SERVICE_NAME': '0', 06:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:24 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 INFO - Downloading docopt-0.6.1.tar.gz 06:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:26 INFO - Running setup.py install for blobuploader 06:55:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:26 INFO - Running setup.py install for requests 06:55:26 INFO - Running setup.py install for docopt 06:55:26 INFO - Successfully installed blobuploader requests docopt 06:55:26 INFO - Cleaning up... 06:55:26 INFO - Return code: 0 06:55:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:26 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:26 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 06:55:26 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 06:55:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:26 INFO - 'HOME': '/Users/cltbld', 06:55:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:26 INFO - 'LOGNAME': 'cltbld', 06:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:26 INFO - 'MOZ_NO_REMOTE': '1', 06:55:26 INFO - 'NO_EM_RESTART': '1', 06:55:26 INFO - 'PAGER': '/bin/cat', 06:55:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:26 INFO - 'PWD': '/builds/slave/test', 06:55:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:26 INFO - 'SHELL': '/bin/bash', 06:55:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:26 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:26 INFO - 'USER': 'cltbld', 06:55:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:26 INFO - 'XPC_FLAGS': '0x0', 06:55:26 INFO - 'XPC_SERVICE_NAME': '0', 06:55:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-mGUZZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-aMZ_Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-dIrjg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ijJIen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1ivXo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-LzWwvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-fWI8Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:27 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-DwAVXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-JH0LLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-gpI3Vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-nCsACY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-nbFN4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-hUSpSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-dLaVo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Gq1WQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-MF8vRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5aXDeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:29 INFO - Running setup.py install for manifestparser 06:55:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:29 INFO - Running setup.py install for mozcrash 06:55:29 INFO - Running setup.py install for mozdebug 06:55:29 INFO - Running setup.py install for mozdevice 06:55:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:29 INFO - Running setup.py install for mozfile 06:55:29 INFO - Running setup.py install for mozhttpd 06:55:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:29 INFO - Running setup.py install for mozinfo 06:55:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for mozInstall 06:55:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for mozleak 06:55:30 INFO - Running setup.py install for mozlog 06:55:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for moznetwork 06:55:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for mozprocess 06:55:30 INFO - Running setup.py install for mozprofile 06:55:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for mozrunner 06:55:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Running setup.py install for mozscreenshot 06:55:31 INFO - Running setup.py install for moztest 06:55:31 INFO - Running setup.py install for mozversion 06:55:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:31 INFO - Cleaning up... 06:55:31 INFO - Return code: 0 06:55:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:31 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')]} 06:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:31 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')]} 06:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:31 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:31 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 06:55:31 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 06:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:31 INFO - 'HOME': '/Users/cltbld', 06:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:31 INFO - 'LOGNAME': 'cltbld', 06:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:31 INFO - 'MOZ_NO_REMOTE': '1', 06:55:31 INFO - 'NO_EM_RESTART': '1', 06:55:31 INFO - 'PAGER': '/bin/cat', 06:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:31 INFO - 'PWD': '/builds/slave/test', 06:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:31 INFO - 'SHELL': '/bin/bash', 06:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:31 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:31 INFO - 'USER': 'cltbld', 06:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:31 INFO - 'XPC_FLAGS': '0x0', 06:55:31 INFO - 'XPC_SERVICE_NAME': '0', 06:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:31 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-tuSD5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-avpcfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-On2ZaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ERDvx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-UP1FrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-eINoUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-X_J701-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-yceGnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-N5EYLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-re3SSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:32 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)) 06:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Kjf_ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-5nvS8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Z_ApG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-lbNNat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-jMUBWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-q5rmFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-sh03sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:33 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)) 06:55:33 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)) 06:55:33 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)) 06:55:33 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)) 06:55:33 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)) 06:55:33 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)) 06:55:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:36 INFO - Downloading blessings-1.6.tar.gz 06:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:36 INFO - Installing collected packages: blessings 06:55:36 INFO - Running setup.py install for blessings 06:55:36 INFO - Successfully installed blessings 06:55:36 INFO - Cleaning up... 06:55:36 INFO - Return code: 0 06:55:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:36 INFO - Reading from file tmpfile_stdout 06:55:36 INFO - Current package versions: 06:55:36 INFO - blessings == 1.6 06:55:36 INFO - blobuploader == 1.2.4 06:55:36 INFO - docopt == 0.6.1 06:55:36 INFO - functools32 == 3.2.3-2 06:55:36 INFO - jsonschema == 2.5.1 06:55:36 INFO - manifestparser == 1.1 06:55:36 INFO - mozInstall == 1.12 06:55:36 INFO - mozcrash == 0.17 06:55:36 INFO - mozdebug == 0.1 06:55:36 INFO - mozdevice == 0.48 06:55:36 INFO - mozfile == 1.2 06:55:36 INFO - mozhttpd == 0.7 06:55:36 INFO - mozinfo == 0.9 06:55:36 INFO - mozleak == 0.1 06:55:36 INFO - mozlog == 3.4 06:55:36 INFO - moznetwork == 0.27 06:55:36 INFO - mozprocess == 0.23 06:55:36 INFO - mozprofile == 0.28 06:55:36 INFO - mozrunner == 6.12 06:55:36 INFO - mozscreenshot == 0.1 06:55:36 INFO - mozsystemmonitor == 0.3 06:55:36 INFO - moztest == 0.7 06:55:36 INFO - mozversion == 1.4 06:55:36 INFO - psutil == 3.1.1 06:55:36 INFO - requests == 1.2.3 06:55:36 INFO - wsgiref == 0.1.2 06:55:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:36 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:36 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 06:55:36 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 06:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:36 INFO - 'HOME': '/Users/cltbld', 06:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:36 INFO - 'LOGNAME': 'cltbld', 06:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:36 INFO - 'MOZ_NO_REMOTE': '1', 06:55:36 INFO - 'NO_EM_RESTART': '1', 06:55:36 INFO - 'PAGER': '/bin/cat', 06:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:36 INFO - 'PWD': '/builds/slave/test', 06:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:36 INFO - 'SHELL': '/bin/bash', 06:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:36 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:36 INFO - 'USER': 'cltbld', 06:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:36 INFO - 'XPC_FLAGS': '0x0', 06:55:36 INFO - 'XPC_SERVICE_NAME': '0', 06:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 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)) 06:55:37 INFO - Cleaning up... 06:55:37 INFO - Return code: 0 06:55:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:37 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 0x101c8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba59c650f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, '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.3mZIPqYIus/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.2nkPsVoh8b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 06:55:37 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 06:55:37 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 06:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:37 INFO - 'HOME': '/Users/cltbld', 06:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:37 INFO - 'LOGNAME': 'cltbld', 06:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:37 INFO - 'MOZ_NO_REMOTE': '1', 06:55:37 INFO - 'NO_EM_RESTART': '1', 06:55:37 INFO - 'PAGER': '/bin/cat', 06:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:37 INFO - 'PWD': '/builds/slave/test', 06:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:37 INFO - 'SHELL': '/bin/bash', 06:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:55:37 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:37 INFO - 'USER': 'cltbld', 06:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:37 INFO - 'XPC_FLAGS': '0x0', 06:55:37 INFO - 'XPC_SERVICE_NAME': '0', 06:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:37 INFO - Cleaning up... 06:55:37 INFO - Return code: 0 06:55:37 INFO - Running post-action listener: _resource_record_post_action 06:55:37 INFO - Running post-action listener: _start_resource_monitoring 06:55:37 INFO - Starting resource monitoring. 06:55:37 INFO - [mozharness: 2016-11-14 14:55:37.378373Z] Finished create-virtualenv step (success) 06:55:37 INFO - [mozharness: 2016-11-14 14:55:37.379201Z] Running install step. 06:55:37 INFO - Running pre-action listener: _resource_record_pre_action 06:55:37 INFO - Running main action method: install 06:55:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:37 INFO - Reading from file tmpfile_stdout 06:55:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:37 INFO - Reading from file tmpfile_stdout 06:55:37 INFO - Output received: 06:55:37 INFO - Usage: mozinstall [options] installer 06:55:37 INFO - Options: 06:55:37 INFO - -h, --help show this help message and exit 06:55:37 INFO - -d DEST, --destination=DEST 06:55:37 INFO - Directory to install application into. [default: 06:55:37 INFO - "/builds/slave/test"] 06:55:37 INFO - --app=APP Application being installed. [default: firefox] 06:55:37 INFO - mkdir: /builds/slave/test/build/application 06:55:37 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'] 06:55:37 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 06:56:10 INFO - Reading from file tmpfile_stdout 06:56:10 INFO - Output received: 06:56:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:56:10 INFO - Running post-action listener: _resource_record_post_action 06:56:10 INFO - [mozharness: 2016-11-14 14:56:10.214116Z] Finished install step (success) 06:56:10 INFO - [mozharness: 2016-11-14 14:56:10.214251Z] Running run-tests step. 06:56:10 INFO - Running pre-action listener: _resource_record_pre_action 06:56:10 INFO - Running main action method: run_tests 06:56:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:10 INFO - 2016-11-14 06:56:10.227 screenresolution[2498:33282] starting screenresolution argv=screenresolution get 06:56:10 INFO - 2016-11-14 06:56:10.229 screenresolution[2498:33282] Display 0: 1600x1200x32@60 06:56:10 INFO - 2016-11-14 06:56:10.234 screenresolution[2499:33284] starting screenresolution argv=screenresolution list 06:56:10 INFO - Available Modes on Display 0 06:56:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:10 INFO - Intel Iris: 06:56:10 INFO - Chipset Model: Intel Iris 06:56:10 INFO - Type: GPU 06:56:10 INFO - Bus: Built-In 06:56:10 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:10 INFO - Vendor: Intel (0x8086) 06:56:10 INFO - Device ID: 0x0a2e 06:56:10 INFO - Revision ID: 0x0009 06:56:10 INFO - Displays: 06:56:10 INFO - Display: 06:56:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:10 INFO - Display Serial Number: 1600x1200 60 06:56:10 INFO - Main Display: Yes 06:56:10 INFO - Mirror: Off 06:56:10 INFO - Online: Yes 06:56:10 INFO - Rotation: Supported 06:56:10 INFO - Return code: 0 06:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:10 INFO - Python 2.7.3 06:56:10 INFO - Return code: 0 06:56:10 INFO - grabbing minidump binary from tooltool 06:56:10 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')]} 06:56:10 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 0x101aa0d30>, '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 0x101906db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a98b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:10 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 06:56:10 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 06:56:10 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 06:56:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:10 INFO - Return code: 0 06:56:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:56:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:56:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:10 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/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 06:56:10 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/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 06:56:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3mZIPqYIus/Render', 06:56:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:10 INFO - 'HOME': '/Users/cltbld', 06:56:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:10 INFO - 'LOGNAME': 'cltbld', 06:56:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:10 INFO - 'MOZ_NO_REMOTE': '1', 06:56:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:10 INFO - 'NO_EM_RESTART': '1', 06:56:10 INFO - 'PAGER': '/bin/cat', 06:56:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:10 INFO - 'PWD': '/builds/slave/test', 06:56:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:10 INFO - 'SHELL': '/bin/bash', 06:56:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2nkPsVoh8b/Listeners', 06:56:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 06:56:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:10 INFO - 'USER': 'cltbld', 06:56:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:10 INFO - 'XPC_FLAGS': '0x0', 06:56:10 INFO - 'XPC_SERVICE_NAME': '0', 06:56:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:10 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/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 06:56:10 INFO - mozversion application_buildid: 20161114015620 06:56:10 INFO - mozversion application_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 06:56:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:56:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:10 INFO - mozversion application_name: Firefox 06:56:10 INFO - mozversion application_remotingname: firefox-dev 06:56:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:10 INFO - mozversion application_vendor: Mozilla 06:56:10 INFO - mozversion application_version: 51.0a2 06:56:10 INFO - mozversion platform_buildid: 20161114015620 06:56:10 INFO - mozversion platform_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 06:56:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:10 INFO - mozversion platform_version: 51.0a2 06:56:10 INFO - using testdate: 1479135370 06:56:10 INFO - actual date: 1479135370 06:56:10 INFO - starting webserver on 'localhost:64515' 06:56:10 INFO - SUITE-START | Running 2 tests 06:56:10 INFO - TEST-START | dromaeo_css 06:56:10 INFO - operating with platform_type : mac_ 06:56:10 INFO - Initialising browser for dromaeo_css test... 06:56:10 INFO - TEST-INFO | started process 2509 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpS0FYi1/profile http://localhost:64515/getInfo.html) 06:56:13 INFO - PROCESS | 2509 | __metrics Screen width/height:1600/1200 06:56:13 INFO - PROCESS | 2509 | colorDepth:24 06:56:13 INFO - PROCESS | 2509 | Browser inner width/height: 1024/689 06:56:13 INFO - PROCESS | 2509 | __metrics 06:56:13 INFO - PROCESS | 2509 | 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" 06:56:13 INFO - PROCESS | 2509 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:14 INFO - TEST-INFO | 2509: exit 0 06:56:14 INFO - Browser initialized. 06:56:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:14 INFO - TEST-INFO | started process 2511 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpS0FYi1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:26 INFO - PROCESS | 2511 | RSS: Main: 220631040 06:56:26 INFO - PROCESS | 2511 | 06:57:17 INFO - PROCESS | 2511 | 1479135437314 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] 06:59:29 INFO - PROCESS | 2511 | Cycle 1(1): loaded http://localhost:64515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64515/tests/dromaeo/cssquery-ext.html) 06:59:30 INFO - PROCESS | 2511 | RSS: Main: 332431360 06:59:30 INFO - PROCESS | 2511 | 07:02:33 INFO - PROCESS | 2511 | Cycle 1(1): loaded http://localhost:64515/tests/dromaeo/cssquery-ext.html (next: http://localhost:64515/tests/dromaeo/cssquery-jquery.html) 07:02:34 INFO - PROCESS | 2511 | RSS: Main: 352575488 07:02:34 INFO - PROCESS | 2511 | 07:05:36 INFO - PROCESS | 2511 | Cycle 1(1): loaded http://localhost:64515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64515/tests/dromaeo/cssquery-mootools.html) 07:05:37 INFO - PROCESS | 2511 | RSS: Main: 322785280 07:05:37 INFO - PROCESS | 2511 | 07:08:39 INFO - PROCESS | 2511 | Cycle 1(1): loaded http://localhost:64515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64515/tests/dromaeo/cssquery-prototype.html) 07:08:40 INFO - PROCESS | 2511 | RSS: Main: 349782016 07:08:40 INFO - PROCESS | 2511 | 07:11:43 INFO - PROCESS | 2511 | Cycle 1(1): loaded http://localhost:64515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64515/tests/dromaeo/cssquery-yui.html) 07:11:43 INFO - PROCESS | 2511 | RSS: Main: 314003456 07:11:43 INFO - PROCESS | 2511 | 07:14:46 INFO - PROCESS | 2511 | Cycle 1(1): loaded http://localhost:64515/tests/dromaeo/cssquery-yui.html (next: http://localhost:64515/tests/dromaeo/cssquery-dojo.html) 07:14:47 INFO - PROCESS | 2511 | RSS: Main: 386166784 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | __start_tp_report 07:14:47 INFO - PROCESS | 2511 | _x_x_mozilla_page_load 07:14:47 INFO - PROCESS | 2511 | _x_x_mozilla_page_load_details 07:14:47 INFO - PROCESS | 2511 | |i|pagename|runs| 07:14:47 INFO - PROCESS | 2511 | |0;dojo.html;3240.789348692335;3251.089694885432;3257.2671148991467;3293.440115180419;3311.652276510966;5570.387257401688;5593.188987596796;5611.3266408031095;5631.127175287832;5649.322081350244;5571.554275657948;5636.070048442002;5641.746121424536;5650;5710.172025056375;5091.516305950938;5119.718415487147;5129.433845478061;5136.306598609196;5188.558972487343;5083.237514372855;5129.666571672848;5213.869653258661;5231.424543300253;5279.234510995903;4219.620234178923;5121.206213036985;5126.641135120524;5162.070827251093;5194.27280180775;5118.181091025437;5134.717590532519;5171.689698618095;5219.791208351661;5223.268742376033;5105.106606343875;5158.226266060084;5167.638265321429;5176.378834539842;5201.08980928336;5422.213779002062;5476.397596264408;5482.698451585161;5496.31296087989;5587.329520457572;6079.422454866781;6143.98624227002;6148.600340977822;6160.630362178284;6175.722092505848;6153.230846144232;6236.18929539157;6255.06174073888;6264.749410023594;6267.9686601567155;5148.176291793295;5237.795307079393;5589.524890384363;5699.401562835926;5761.884762304772;6175.197224360804;6253.96873015632;6309.747610095545;6318.178636777281;6325.272593651697;6077.270727512639;6085.366096101532;6092.39076092396;6106.755729770848;6124;6136.592867771182;6152.907706384408;6230.719617617218;6231.750729970841;6239.282482514569;4957.925631115536;5920.31916329619;5996.760129594854;6009.909851352233;6084.209052823193;6151.138840562325;6151.292601350812;6172.043333283348;6177;6193.163922870445;4842.661013729005;4866.221404575322;4866.221404575322;4870.025994801054;4892.68197567157;4333.913321733611;4334.393184954109;4357.150355680612;4372.868813935587;4400.537943515948;4726.740029298421;5580.135079062752;5671.376148623648;5682;5699.515541178963;6130.275842464065;6256;6257;6264.5301602380005;6277.497800175975;5621.8594535136135;5686.77252909879;5699.059655156935;5701.657900525982;5709.7716091356715;5220.295260139908;5286.444923283077;5346.4118946915805;5357.383900851374;5360.981413531416;6257.2491301044165;6303.117563541016;6315.431611155018;6326.6836658165985;6328.746850125944;6101.389861013863;6135.477655820289;6149.524114212646;6257.4994000480765;6258.311585725475;6235.563510554399;6280.371962803683;6310.558260921692;6313.273973492924;6313.842153946004;5874.882502350015;6060.848478788065;6083.847903802441;6097.75608975636;6111.083337499233;6068.726907289094;6099.176611157437;6110.224634763396;6120.843333897588;6146.170267014075;6019.187409699634;6028.125921741411;6029;6044.848878778066;6075.2405949256345;5828.358880523224;5938.168656388023;6003.129546215687;6018.21763170785;6036.456718895145;5697.914531282117;5729.828105156852;5743.224664670216;5856.736446859987;5866.853328666647;5948.048312270016;5970.0746384310505;5977.551683623658;6090.573659843769;6127.264728232641;5831.300243970751;5852.473277404883;5853.531717462678;5873.4126587340925;5911.881762364815 07:14:47 INFO - PROCESS | 2511 | |1;ext.html;466.9042846216526;499.9750511451521;513.4275283059385;515.4072816261299;516.5867306155075;29758.85120574397;39659;40865.387019194735;40941.18117637649;43030.56969430305;42417.151656966846;42757.57242427575;42811.57188428115;42848.78575607125;42886.35670464946;9685.515724213796;9889.703308900709;9889.75275618108;9898.50507474627;9928.255380846465;9653.27600429967;9768.023197680246;9777.217822574177;9781.902180978206;9787.46168960707;9587.13715765581;9728.854067188999;9790.90209097907;9815.65645202418;9816.901830981671;9742.07450292221;9752.561134748918;9790.608375664964;9790.657326993593;9806.705798826082;9701.6604418845;9775.51122443882;9788.853167202498;9791.902080979171;9816.361936474106;40189;40541.59458405407;40552.391714124315;40572.188556229004;40606;3250.2686895448574;3586.5337506124297;3598.1004748812798;3785.5078839750654;3851.0757418219705;29538;30786.23034424135;31358.216044599067;32009.679903200904;32461;3103.286244163832;3153.1013661106704;3201.9039428817173;3404.7616666833333;3416.538767266412;476993;482028;484888;485181;486246;59913.40086599165;60082.69958650179;60510.69744651337;60566;60573.69713151406;65814.67092664506;65912.67043664752;65923.67038164778;66059.6788064236;66069;14236.932230082784;16941.23764430579;17125.22936467862;17138.885972411754;17172.96962182273;13156.881665058385;13177.802332965013;13179.60461186166;13196.406161722745;13201.339933003312;16236.75644865328;18130.546736331435;18165.819221750546;18167.273309067754;18183.909080454512;5291.920621190685;6377.362263773585;6447.774327898501;6485.578437401554;6521;898.6135961536471;983.896690847465;995.5271246158017;1020.8672872526524;1085.7285678580356;29347.706522934925;29691;29894.40211195764;30556.69443305583;30618.69381306203;883.7878909061908;1026.553449249564;1057.5769692123213;1076.5424694504804;1157.9305241685358;14683.55949321522;15102.471413500694;15181.405952374842;15192.696146077238;15470.690586188213;650272;657695;657923;658408;659781;58809.41190588125;58840.41159588435;58896.41103588909;58973;59391.703041484514;1081.291753901196;1335.6660834791303;1383.8339399272152;1384.2248340928911;1385.161977003898;28779.856100719364;29057;29326.680299386153;30046.098617041524;30105.849470752506;50862.23706644329;51293.230601541756;51383.48616513787;51406;51422.97154056823;615136;618386;618614;622743;623021;40054.39646422973;41293.96765080897;41663;41849.1630167401;41945.79027104845;46756.29865552088;46796.29805552988;48125.27812082751;48890.266645999625;50055.49944500509;39331.2133757329;39800.60199398085;40291;41257.174856503305;41493.79253103715;33641.831790840886;38728.41907371448;39006.80496597499;40298.1940361197;40475.78572642826;37739.62260377471;38141;38165.618343816204;38198;38768.41847372348;33471.33057338791;34743.30513389769;35023;35372.469412958315;35544.28911421809;25884.35289117787;25957.00312794827;25976.8701156493;26320.8683956579;26452.73547264503 07:14:47 INFO - PROCESS | 2511 | |2;jquery.html;320.9550662907193;322.35850657192185;343.6426116838488;361.75219974317594;383.39997903281363;15219.391224351026;15680.294386752596;15853.84146158538;17898.194581243843;21196.89401552994;19738.21047158112;20710;20925.47686307839;20978.475538111554;21185.68221476679;6774.220964589062;6794.626295553742;7132.679029443688;7136.536125151874;7139.85720285594;6944.097267355262;7101.325374089453;7122.537035092729;7122.821929451779;7133.286671332877;4611.815527378918;4695.389599352096;4979.352684151056;7117.466190035742;7551.924480755205;7623.085229772463;8205.753827385188;8210.30212431938;8220.547869867154;8225.8354832903;7705.152433232396;7831.334336581397;7833.764987050341;7850.568218747967;7854;28152;28193.85903070492;28716;28919.987800426883;29136.8543157285;2416.1664225842055;2463.97536024641;2473.060237109905;2606.713261541229;3277.0987978306157;16270.593235169097;17179.570510737205;17575.648487030314;17712.734308985375;18059.729104063448;1764.1443899708631;2041.8774873507637;2053.4455696961886;2060.248009476545;2063.8348932085396;87086;130682;134497.98253026212;144134;147079.11683532645;15561.455349062728;17769.644607107784;19427.125779339964;20020.299289524795;21473.892630536746;31141.844290778856;34316.82841585776;34964.951051468495;35193.47209791855;35217.47173792395;10556.630517931835;10854.93756186322;11004.284721493077;11023.503942322615;11178.888211117785;9034.954825225832;9052.637894484147;9098.31762617793;9230.261579073658;9255.074492550692;8300.256946041278;9164.175224229852;9448.811023779486;9663.226941844636;9710.70867873965;3721.4603882436895;3732.8133593320226;3740.6072362401555;3821.764267903252;3871.264459752638;853.2875049333752;924.408378637659;981.5828272983953;1008.6620981971122;1034.7568321444455;20008.099635516435;21428.678569821466;21429;21441.46396340104;21512.892435537724;944.6032666280179;950.3395140377371;975.7463059604412;985.4383001688968;991.1872264742842;9005.909940900638;10945.616903408343;11473.885261147281;11486.368249746343;11497.482613282422;604043.979780107;621713;626408;640198;645102;142605.57394425923;143350.2832485831;143457;147684;149451;974.6734843827255;1009.4548943570389;1018.6638409324905;1018.8064267789097;1024.1141412678128;18881;19866.90066549658;20067.899660501604;20267.898660506602;20279.898600506902;55957.58608455852;58827;59074;59200.40799592121;59482.70258648679;82543;84054;85639.57180214059;86205;88220;7895.84208315842;7981.241782030698;8034.47775894565;8136.959315203386;8323.583820809057;10943.781124377627;11540.769184616429;12440.129190956908;12714.491420343084;13008.934955325163;10746.194035447217;10797.784044318912;10835.837462437912;11158.832617510581;11361.091112711129;5057.747112644427;7484.812879678052;10829.079528240189;10961.342319460859;11287.604933827277;10709.90611703833;10944.507497162487;10973.012428881439;11320.320780753182;11348.659540213806;7244.927550724426;7895.171007044178;7924.524528528076;8139.4709343892455;8360.205780450848;7829.060512738508;10235;10635.574577016832;10644.574217031231;11153.553857845594 07:14:47 INFO - PROCESS | 2511 | |3;mootools.html;1316.4799904037911;1473.8968272220943;1499.8200215974084;1674.271691814061;1860.6185731924948;7786.221377862211;8397.286230670392;8666.826663466727;8866.822663546725;8871.512066836322;8808.986966498855;8895.110488951117;8897.466152030882;8898.377113602035;8930.821383572325;2379.916702915398;2408.421978725111;2409.722881868581;2415.1909110448023;2417.359399759065;2373.7151541815006;2408.51829634073;2417.6494408310787;2421.4672771990136;2421.539907417594;2393.7845593896545;2400.639904014403;2411.8070554355695;2422.4186195313173;2423.866687332196;2360.8701521416315;2383.189715496731;2389.8446600970883;2391.8804059797026;2397.4006498375234;2353.8940747666397;2372.6678265042906;2377.869217193054;2381.666566680666;2382.1900553811615;8771.649134034631;8803.427777194462;8850.867236991451;8909.554522273926;8915.42049766763;5270.130428479296;5493.587980901409;5501.972490137564;5507.669539827623;5517.144842549411;3570.83931223093;3602.603713591503;3633.4731463937846;3676.8896933091783;3678.528588564569;957.7979635557331;1102.189890430541;1103.5144536403957;1125.094299089233;1126.9492872820742;11781.705457363549;11878.881211187863;11935.283882966964;11945.820812687816;11975.760484790255;4472.239719247736;4526.705764125387;4696.835610753607;4708.858734237979;4718.4809670936165;9256.305777066747;9266.583003764847;9277.211437027794;9280.582373793195;9281.164695177466;5262.1317482615705;5278.392984806719;5284.630075894651;5291;5291.470852914677;3866.3233934061427;4164.729292596032;4367.956320436819;4562.908741825211;4935.481774413706;3813.809309534512;3852.4028775539837;3900.4539364488996;3922.5096862892137;3931.744436611611;1179.6461061681462;1188.6493484422117;1190.7380376317196;1197.8502687164105;1200.5077918053555;779.2986312318958;866.2204016385303;909.8862642169729;924.5654542365078;927.9907200928039;5774.220480235199;5908.231929849092;5948.464638182584;5961.850953726105;6167.229096362955;830.2154464031432;920.1718453391867;928.8374534456443;961.1685891703765;969.0842154164247;3027.818330900153;3816.675582575512;3973.7417067890497;4007.2786898358577;4190.141021090669;10900;10952.3428594283;11091.112710983101;11100.167487438475;11154.274972126786;10571.894281057244;10912;11095.72260693489;11110.388928609003;11121.499532520895;8128.471649342774;8139.511629302261;8195.180481951757;8365.539895305817;8382.07797142314;5944.64332140073;6014.939850601613;6109.480694141048;6163.260408750979;6166.907496387647;9925.454100024568;10250.718660167478;10296.948515257376;10324.174066074846;10447.738806529593;9393.233939274025;9888.703338899844;10336.741581460523;10404.959504049535;10528.526216320131;6482.985223576325;7453.068366454193;7664.463487555818;7786;7814.6483408247905;8338.708145214889;8366.205210504992;8375.664973401239;8401.537915414467;8504.362172836938;7405.222451642716;7444.218357072429;7504.512206706547;7679.884801727867;7707.961460192663;7477.850442991218;7500.174980752004;7511.248875112445;7522.548647080974;7582.317591416799;6878.27778083294;7114.075170227838;7116;7157.964210179124;7160.140783106061;4819.734914579732;4880.438749543706;4995.975020124876;5144.048351055067;5221.190715439113;4636.304554316879;5102.08162530748;5113.795448182031;5373.489518495737;5447.972760136174 07:14:47 INFO - PROCESS | 2511 | |4;prototype.html;289.3951641070163;295.23681283881166;304.4626234695762;308.17101995631765;311.32597925491314;5141.018209438526;5215.765290561924;5272.209168624709;5297.549708274796;5297.629165958385;5009.373828271466;5149.974250128754;5202.141646628311;5222.321098257231;5232.73836308184;3987.262356464049;3992.281389349916;4000.8399664013405;4011.8595849145213;4014.9397759033636;3997.7401468904427;3997.880063598082;4016.819243134066;4020.939685904699;4080.10237747695;3232.4989626607794;3271.509273608966;3466.185446420089;3905.453236546886;3968.7420317679403;3612.981935090321;3934.783586902719;3947.881563553098;3952.3281042222893;3963.9297389704907;2824.364517983458;3401.183715908189;3401.1973653963437;3409.403354412968;3420.110771199506;4322.82708691652;4413.249747542925;4776;5071.442141364447;5072.289879416885;3917.8236979335998;4437.977810110961;4501.527339629357;4526.434195725535;4536.2741961286365;4622.884427889296;5103.770330335106;5467.6719396836315;5480.369757477902;5516.668999860021;3136.38840426117;3733.2906747718116;3751.9062023449633;3759.5300587426573;3771.510253449899;5416.864578385572;5440.63984003999;5651.7456714447535;5663.366534561449;5744.569157313176;3601.37099917062;3684.502592150079;3766.3597188478025;3818.2554401891366;3828.636279553438;3544.2734239480847;3562.928741425209;3876.402810117228;3891.747036442622;3899.200663863901;3684.4473329000866;3754.887353379403;4008.4187792769885;4525.411696479437;4577.656675749332;4916.680415772963;5233.502817232356;5463.48096930791;5503.532199763065;5525.668459892419;1085.0993675249524;1274.4647248155798;1307.5292894557952;1311.3902035553513;1314.9283334082693;736.5727877830846;758.8899609556694;792.6750032486652;792.9960350198212;818.9036067666673;3765.9246815064093;3810.627594578818;3841.7118716096406;4334.461266250499;4378.605925466723;3839.7120215983914;4237.618614324726;4589.885252868705;4725.817651378555;4733.337332773414;3515.2969406118877;3726.832292546842;3775.5091838061426;4314.203500919171;4409.2724700424715;2158.4711745622108;2325.0469605531434;2456.9975469992255;2472.2088931542094;2485.4159272570932;4352.891177720582;4711.434627844681;4898;4898.657094003457;4925.620826168679;3918.0418783818036;4027.597240275949;4454.844080457168;4605.509628112563;4643.931895664016;4170.186813571325;4371;4393.714408563369;4649.790759415834;4895.534924182197;4027.275090483624;4377.409049778239;4729.361536192708;4734.73958932262;4747.976260118678;4454.710443821141;4482;4673.859784206479;4696.551999680354;4730.2195137803255;4620.1221767865345;4864.416270047617;4878.390201224847;5018.924716129188;5419.458054194549;3761.2289480656946;3778.5843557208136;3796.924061518699;3814.3134235837815;3831.731778775459;4620.353150558857;5669.54643628517;5669.886602267849;5684.459976302244;5711.086226203787;5341.996751218293;5403.756830942696;5412.890357476629;5524.66851988882;5539.667619942817;5317.282166907573;5456.2906822114455;5465;5470.72646367688;5518.606057274827;5354.170103633943;5354.598405119554;5377.569794416516;5379.408265090915;5383.016567739923;5140.43455219918;5455.563554915518;5467.528119644134;5472.5621950243085;5590.608657394106;4508.549145085596;5354.643956659058;5354.678719276856;5381;5385.569154467555 07:14:47 INFO - PROCESS | 2511 | |5;yui.html;718.6765955320105;719.9999999999997;737.3327138939259;781.3583156727208;806.850732614466;16823.074730889795;17080.316787328524;17087.401940932068;17098.91450542747;17534.736978945293;16567.50297491074;16729.832701672978;16743.497695069138;16749.330026798943;16755.66488670226;675.8715843989626;694.8228201808532;820.1306614988117;852.8720691896234;860.3547339495378;683.1904193530657;824.6495239523209;830.1947111302028;843.5782108945527;843.9240468357847;892.7946572288345;897.6947837735169;898.2275243290765;899.244634507014;899.4648184330346;686.9003994420831;703.4688809948507;893.3835653399166;895.4895709445651;898.4160295807712;645.2321737132797;650.4763665249473;656.4092316914815;657.2868437745052;660.1121491593799;15612.375504979787;15653.843461565353;15655.295511702001;15657.843421565753;15659.843401565953;13426.261555614437;13654.453821847113;13766.518171864036;13805.51680691171;13982.790258146137;11226.775464490664;11714.472848721827;11727.296362218294;12231.449584768707;12331.732090995893;3770.1140232045445;3815.2470127873507;3850.172212974196;3858.2090671412293;3947.842086316544;113556;115635;120194;121072;121607.78392216141;9500.857487137699;10766.246362754531;10853.131749460024;11095.389753563632;11247.325160490396;17996.55008624795;21644.45888852791;21662.675059874113;21905.780942190373;22054.11783528673;8042.356611471068;8064.55644939534;8101.959490202511;8139.959300203461;8214.8357032859;4178.6448151907425;4202.726822756511;4287.721298115613;4303.612674859278;4323.308270676676;3129.921751956174;3605.0446631642635;3734.3464893643504;3739.3456145174487;3749.9062523436587;664.3423011218858;665.6339013542629;677.7932730517141;681.6523572977718;684.5174152222671;588.4409810679871;621.9284782250008;640.3820313397594;655.7245956698102;673.2291526202569;9279.72160835176;9712.223022158352;9749.171320437701;9802.313838031268;9802.558884850056;559.1556749308492;567.5884983387011;641.6599202422724;661.4509956735898;694.4513834071028;4295.453636690789;4383.736975781463;4769.59421069946;4784.330193772875;4869.878253043631;157966;162408;166578.50132248027;169181;180215;92259;141194;142881;144991;154072.3778286653;123389.38305308236;124970.75029249773;127118;127283;128423.71576284304;8945;9245.260379169516;9281.211097056826;9351.625934962525;9471.66849160276;64522.709545807884;65642.67178664076;66021.33978660151;66951.99572006326;68634.65682671555;95552;100105.49947250217;101643;104035;106643.40034899638;10798.784024319626;11128.332300062022;11238.606648767254;11401.258918170292;11667.358295293501;12922.935385323013;13303.707541623844;13454.865451345362;13573.321333933462;13844.10013349129;11765.176437649283;12025;12375.504979800708;12516.499340026661;12906.354682266037;12248.816267756169;12378.938105309417;12452.750944980868;12468.940140088194;12936.547220847226;11574.363410012193;12077.214981026205;12289.1397602167;12386.071044671866;12394.690132746393;8589.398742087993;9469.573869176042;9891.35706179096;10036.447995360033;10096.444695541815;9890.159336456481;10639.308444951053;10848;10903.509342079784;10912.181586381212 07:14:47 INFO - PROCESS | 2511 | __end_tp_report 07:14:47 INFO - PROCESS | 2511 | __start_cc_report 07:14:47 INFO - PROCESS | 2511 | _x_x_mozilla_cycle_collect,1617 07:14:47 INFO - PROCESS | 2511 | __end_cc_report 07:14:47 INFO - PROCESS | 2511 | __startTimestamp1479136487250__endTimestamp 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | ------- Summary: start ------- 07:14:47 INFO - PROCESS | 2511 | Number of tests: 6 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | [#0] dojo.html Cycles:165 Average:5653.74 Median:5853.53 stddev:657.67 (11.2%) stddev-sans-first:631.85 07:14:47 INFO - PROCESS | 2511 | Values: 3240.8 3251.1 3257.3 3293.4 3311.7 5570.4 5593.2 5611.3 5631.1 5649.3 5571.6 5636.1 5641.7 5650.0 5710.2 5091.5 5119.7 5129.4 5136.3 5188.6 5083.2 5129.7 5213.9 5231.4 5279.2 4219.6 5121.2 5126.6 5162.1 5194.3 5118.2 5134.7 5171.7 5219.8 5223.3 5105.1 5158.2 5167.6 5176.4 5201.1 5422.2 5476.4 5482.7 5496.3 5587.3 6079.4 6144.0 6148.6 6160.6 6175.7 6153.2 6236.2 6255.1 6264.7 6268.0 5148.2 5237.8 5589.5 5699.4 5761.9 6175.2 6254.0 6309.7 6318.2 6325.3 6077.3 6085.4 6092.4 6106.8 6124.0 6136.6 6152.9 6230.7 6231.8 6239.3 4957.9 5920.3 5996.8 6009.9 6084.2 6151.1 6151.3 6172.0 6177.0 6193.2 4842.7 4866.2 4866.2 4870.0 4892.7 4333.9 4334.4 4357.2 4372.9 4400.5 4726.7 5580.1 5671.4 5682.0 5699.5 6130.3 6256.0 6257.0 6264.5 6277.5 5621.9 5686.8 5699.1 5701.7 5709.8 5220.3 5286.4 5346.4 5357.4 5361.0 6257.2 6303.1 6315.4 6326.7 6328.7 6101.4 6135.5 6149.5 6257.5 6258.3 6235.6 6280.4 6310.6 6313.3 6313.8 5874.9 6060.8 6083.8 6097.8 6111.1 6068.7 6099.2 6110.2 6120.8 6146.2 6019.2 6028.1 6029.0 6044.8 6075.2 5828.4 5938.2 6003.1 6018.2 6036.5 5697.9 5729.8 5743.2 5856.7 5866.9 5948.0 5970.1 5977.6 6090.6 6127.3 5831.3 5852.5 5853.5 5873.4 5911.9 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | [#1] ext.html Cycles:180 Average:72354.95 Median:41393.88 stddev:158033.21 (381.8%) stddev-sans-first:158384.36 07:14:47 INFO - PROCESS | 2511 | Values: 466.9 500.0 513.4 515.4 516.6 29758.9 39659.0 40865.4 40941.2 43030.6 42417.2 42757.6 42811.6 42848.8 42886.4 9685.5 9889.7 9889.8 9898.5 9928.3 9653.3 9768.0 9777.2 9781.9 9787.5 9587.1 9728.9 9790.9 9815.7 9816.9 9742.1 9752.6 9790.6 9790.7 9806.7 9701.7 9775.5 9788.9 9791.9 9816.4 40189.0 40541.6 40552.4 40572.2 40606.0 3250.3 3586.5 3598.1 3785.5 3851.1 29538.0 30786.2 31358.2 32009.7 32461.0 3103.3 3153.1 3201.9 3404.8 3416.5 476993.0 482028.0 484888.0 485181.0 486246.0 59913.4 60082.7 60510.7 60566.0 60573.7 65814.7 65912.7 65923.7 66059.7 66069.0 14236.9 16941.2 17125.2 17138.9 17173.0 13156.9 13177.8 13179.6 13196.4 13201.3 16236.8 18130.5 18165.8 18167.3 18183.9 5291.9 6377.4 6447.8 6485.6 6521.0 898.6 983.9 995.5 1020.9 1085.7 29347.7 29691.0 29894.4 30556.7 30618.7 883.8 1026.6 1057.6 1076.5 1157.9 14683.6 15102.5 15181.4 15192.7 15470.7 650272.0 657695.0 657923.0 658408.0 659781.0 58809.4 58840.4 58896.4 58973.0 59391.7 1081.3 1335.7 1383.8 1384.2 1385.2 28779.9 29057.0 29326.7 30046.1 30105.8 50862.2 51293.2 51383.5 51406.0 51423.0 615136.0 618386.0 618614.0 622743.0 623021.0 40054.4 41294.0 41663.0 41849.2 41945.8 46756.3 46796.3 48125.3 48890.3 50055.5 39331.2 39800.6 40291.0 41257.2 41493.8 33641.8 38728.4 39006.8 40298.2 40475.8 37739.6 38141.0 38165.6 38198.0 38768.4 33471.3 34743.3 35023.0 35372.5 35544.3 25884.4 25957.0 25976.9 26320.9 26452.7 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | [#2] jquery.html Cycles:180 Average:38342.27 Median:15731.40 stddev:105110.97 (668.2%) stddev-sans-first:105367.07 07:14:47 INFO - PROCESS | 2511 | Values: 321.0 322.4 343.6 361.8 383.4 15219.4 15680.3 15853.8 17898.2 21196.9 19738.2 20710.0 20925.5 20978.5 21185.7 6774.2 6794.6 7132.7 7136.5 7139.9 6944.1 7101.3 7122.5 7122.8 7133.3 4611.8 4695.4 4979.4 7117.5 7551.9 7623.1 8205.8 8210.3 8220.5 8225.8 7705.2 7831.3 7833.8 7850.6 7854.0 28152.0 28193.9 28716.0 28920.0 29136.9 2416.2 2464.0 2473.1 2606.7 3277.1 16270.6 17179.6 17575.6 17712.7 18059.7 1764.1 2041.9 2053.4 2060.2 2063.8 87086.0 130682.0 134498.0 144134.0 147079.1 15561.5 17769.6 19427.1 20020.3 21473.9 31141.8 34316.8 34965.0 35193.5 35217.5 10556.6 10854.9 11004.3 11023.5 11178.9 9035.0 9052.6 9098.3 9230.3 9255.1 8300.3 9164.2 9448.8 9663.2 9710.7 3721.5 3732.8 3740.6 3821.8 3871.3 853.3 924.4 981.6 1008.7 1034.8 20008.1 21428.7 21429.0 21441.5 21512.9 944.6 950.3 975.7 985.4 991.2 9005.9 10945.6 11473.9 11486.4 11497.5 604044.0 621713.0 626408.0 640198.0 645102.0 142605.6 143350.3 143457.0 147684.0 149451.0 974.7 1009.5 1018.7 1018.8 1024.1 18881.0 19866.9 20067.9 20267.9 20279.9 55957.6 58827.0 59074.0 59200.4 59482.7 82543.0 84054.0 85639.6 86205.0 88220.0 7895.8 7981.2 8034.5 8137.0 8323.6 10943.8 11540.8 12440.1 12714.5 13008.9 10746.2 10797.8 10835.8 11158.8 11361.1 5057.7 7484.8 10829.1 10961.3 11287.6 10709.9 10944.5 10973.0 11320.3 11348.7 7244.9 7895.2 7924.5 8139.5 8360.2 7829.1 10235.0 10635.6 10644.6 11153.6 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | [#3] mootools.html Cycles:180 Average:5747.01 Median:5107.94 stddev:3244.26 (63.5%) stddev-sans-first:3236.27 07:14:47 INFO - PROCESS | 2511 | Values: 1316.5 1473.9 1499.8 1674.3 1860.6 7786.2 8397.3 8666.8 8866.8 8871.5 8809.0 8895.1 8897.5 8898.4 8930.8 2379.9 2408.4 2409.7 2415.2 2417.4 2373.7 2408.5 2417.6 2421.5 2421.5 2393.8 2400.6 2411.8 2422.4 2423.9 2360.9 2383.2 2389.8 2391.9 2397.4 2353.9 2372.7 2377.9 2381.7 2382.2 8771.6 8803.4 8850.9 8909.6 8915.4 5270.1 5493.6 5502.0 5507.7 5517.1 3570.8 3602.6 3633.5 3676.9 3678.5 957.8 1102.2 1103.5 1125.1 1126.9 11781.7 11878.9 11935.3 11945.8 11975.8 4472.2 4526.7 4696.8 4708.9 4718.5 9256.3 9266.6 9277.2 9280.6 9281.2 5262.1 5278.4 5284.6 5291.0 5291.5 3866.3 4164.7 4368.0 4562.9 4935.5 3813.8 3852.4 3900.5 3922.5 3931.7 1179.6 1188.6 1190.7 1197.9 1200.5 779.3 866.2 909.9 924.6 928.0 5774.2 5908.2 5948.5 5961.9 6167.2 830.2 920.2 928.8 961.2 969.1 3027.8 3816.7 3973.7 4007.3 4190.1 10900.0 10952.3 11091.1 11100.2 11154.3 10571.9 10912.0 11095.7 11110.4 11121.5 8128.5 8139.5 8195.2 8365.5 8382.1 5944.6 6014.9 6109.5 6163.3 6166.9 9925.5 10250.7 10296.9 10324.2 10447.7 9393.2 9888.7 10336.7 10405.0 10528.5 6483.0 7453.1 7664.5 7786.0 7814.6 8338.7 8366.2 8375.7 8401.5 8504.4 7405.2 7444.2 7504.5 7679.9 7708.0 7477.9 7500.2 7511.2 7522.5 7582.3 6878.3 7114.1 7116.0 7158.0 7160.1 4819.7 4880.4 4996.0 5144.0 5221.2 4636.3 5102.1 5113.8 5373.5 5448.0 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | [#4] prototype.html Cycles:180 Average:4183.88 Median:4505.04 stddev:1289.58 (28.6%) stddev-sans-first:1259.63 07:14:47 INFO - PROCESS | 2511 | Values: 289.4 295.2 304.5 308.2 311.3 5141.0 5215.8 5272.2 5297.5 5297.6 5009.4 5150.0 5202.1 5222.3 5232.7 3987.3 3992.3 4000.8 4011.9 4014.9 3997.7 3997.9 4016.8 4020.9 4080.1 3232.5 3271.5 3466.2 3905.5 3968.7 3613.0 3934.8 3947.9 3952.3 3963.9 2824.4 3401.2 3401.2 3409.4 3420.1 4322.8 4413.2 4776.0 5071.4 5072.3 3917.8 4438.0 4501.5 4526.4 4536.3 4622.9 5103.8 5467.7 5480.4 5516.7 3136.4 3733.3 3751.9 3759.5 3771.5 5416.9 5440.6 5651.7 5663.4 5744.6 3601.4 3684.5 3766.4 3818.3 3828.6 3544.3 3562.9 3876.4 3891.7 3899.2 3684.4 3754.9 4008.4 4525.4 4577.7 4916.7 5233.5 5463.5 5503.5 5525.7 1085.1 1274.5 1307.5 1311.4 1314.9 736.6 758.9 792.7 793.0 818.9 3765.9 3810.6 3841.7 4334.5 4378.6 3839.7 4237.6 4589.9 4725.8 4733.3 3515.3 3726.8 3775.5 4314.2 4409.3 2158.5 2325.0 2457.0 2472.2 2485.4 4352.9 4711.4 4898.0 4898.7 4925.6 3918.0 4027.6 4454.8 4605.5 4643.9 4170.2 4371.0 4393.7 4649.8 4895.5 4027.3 4377.4 4729.4 4734.7 4748.0 4454.7 4482.0 4673.9 4696.6 4730.2 4620.1 4864.4 4878.4 5018.9 5419.5 3761.2 3778.6 3796.9 3814.3 3831.7 4620.4 5669.5 5669.9 5684.5 5711.1 5342.0 5403.8 5412.9 5524.7 5539.7 5317.3 5456.3 5465.0 5470.7 5518.6 5354.2 5354.6 5377.6 5379.4 5383.0 5140.4 5455.6 5467.5 5472.6 5590.6 4508.5 5354.6 5354.7 5381.0 5385.6 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - PROCESS | 2511 | [#5] yui.html Cycles:180 Average:26489.81 Median:3736.85 stddev:43966.35 (1176.6%) stddev-sans-first:44047.11 07:14:47 INFO - PROCESS | 2511 | Values: 718.7 720.0 737.3 781.4 806.9 16823.1 17080.3 17087.4 17098.9 17534.7 16567.5 16729.8 16743.5 16749.3 16755.7 675.9 694.8 820.1 852.9 860.4 683.2 824.6 830.2 843.6 843.9 892.8 897.7 898.2 899.2 899.5 686.9 703.5 893.4 895.5 898.4 645.2 650.5 656.4 657.3 660.1 15612.4 15653.8 15655.3 15657.8 15659.8 13426.3 13654.5 13766.5 13805.5 13982.8 11226.8 11714.5 11727.3 12231.4 12331.7 3770.1 3815.2 3850.2 3858.2 3947.8 113556.0 115635.0 120194.0 121072.0 121607.8 9500.9 10766.2 10853.1 11095.4 11247.3 17996.6 21644.5 21662.7 21905.8 22054.1 8042.4 8064.6 8102.0 8140.0 8214.8 4178.6 4202.7 4287.7 4303.6 4323.3 3129.9 3605.0 3734.3 3739.3 3749.9 664.3 665.6 677.8 681.7 684.5 588.4 621.9 640.4 655.7 673.2 9279.7 9712.2 9749.2 9802.3 9802.6 559.2 567.6 641.7 661.5 694.5 4295.5 4383.7 4769.6 4784.3 4869.9 157966.0 162408.0 166578.5 169181.0 180215.0 92259.0 141194.0 142881.0 144991.0 154072.4 123389.4 124970.8 127118.0 127283.0 128423.7 8945.0 9245.3 9281.2 9351.6 9471.7 64522.7 65642.7 66021.3 66952.0 68634.7 95552.0 100105.5 101643.0 104035.0 106643.4 10798.8 11128.3 11238.6 11401.3 11667.4 12922.9 13303.7 13454.9 13573.3 13844.1 11765.2 12025.0 12375.5 12516.5 12906.4 12248.8 12378.9 12452.8 12468.9 12936.5 11574.4 12077.2 12289.1 12386.1 12394.7 8589.4 9469.6 9891.4 10036.4 10096.4 9890.2 10639.3 10848.0 10903.5 10912.2 07:14:47 INFO - PROCESS | 2511 | -------- Summary: end -------- 07:14:47 INFO - PROCESS | 2511 | 07:14:47 INFO - TEST-INFO | 2511: exit 0 07:14:47 INFO - TEST-OK | dromaeo_css | took 1117011ms 07:14:47 INFO - TEST-START | kraken 07:14:47 INFO - operating with platform_type : mac_ 07:14:47 INFO - Initialising browser for kraken test... 07:14:47 INFO - TEST-INFO | started process 2513 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmprEkxhT/profile http://localhost:64515/getInfo.html) 07:14:50 INFO - PROCESS | 2513 | __metrics Screen width/height:1600/1200 07:14:50 INFO - PROCESS | 2513 | colorDepth:24 07:14:50 INFO - PROCESS | 2513 | Browser inner width/height: 1024/689 07:14:50 INFO - PROCESS | 2513 | __metrics 07:14:50 INFO - PROCESS | 2513 | 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" 07:14:50 INFO - PROCESS | 2513 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:51 INFO - TEST-INFO | 2513: exit 0 07:14:51 INFO - Browser initialized. 07:14:51 INFO - Running cycle 1/1 for kraken test... 07:14:51 INFO - TEST-INFO | started process 2514 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmprEkxhT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:03 INFO - PROCESS | 2514 | RSS: Main: 219865088 07:15:03 INFO - PROCESS | 2514 | 07:15:05 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64515/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:06 INFO - PROCESS | 2514 | RSS: Main: 270565376 07:15:06 INFO - PROCESS | 2514 | 07:15:09 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64515/tests/kraken/driver.html?testName=audio-dft) 07:15:09 INFO - PROCESS | 2514 | RSS: Main: 281481216 07:15:09 INFO - PROCESS | 2514 | 07:15:12 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64515/tests/kraken/driver.html?testName=audio-fft) 07:15:13 INFO - PROCESS | 2514 | RSS: Main: 379936768 07:15:13 INFO - PROCESS | 2514 | 07:15:15 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64515/tests/kraken/driver.html?testName=audio-oscillator) 07:15:16 INFO - PROCESS | 2514 | RSS: Main: 280793088 07:15:16 INFO - PROCESS | 2514 | 07:15:18 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:18 INFO - PROCESS | 2514 | RSS: Main: 282251264 07:15:18 INFO - PROCESS | 2514 | 07:15:21 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64515/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:22 INFO - PROCESS | 2514 | RSS: Main: 320397312 07:15:22 INFO - PROCESS | 2514 | 07:15:24 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64515/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:25 INFO - PROCESS | 2514 | RSS: Main: 319995904 07:15:25 INFO - PROCESS | 2514 | 07:15:28 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64515/tests/kraken/driver.html?testName=json-parse-financial) 07:15:29 INFO - PROCESS | 2514 | RSS: Main: 316837888 07:15:29 INFO - PROCESS | 2514 | 07:15:30 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:31 INFO - PROCESS | 2514 | RSS: Main: 292319232 07:15:31 INFO - PROCESS | 2514 | 07:15:33 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:33 INFO - PROCESS | 2514 | RSS: Main: 297590784 07:15:33 INFO - PROCESS | 2514 | 07:15:36 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:36 INFO - PROCESS | 2514 | RSS: Main: 305483776 07:15:36 INFO - PROCESS | 2514 | 07:15:39 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:40 INFO - PROCESS | 2514 | RSS: Main: 310390784 07:15:40 INFO - PROCESS | 2514 | 07:15:43 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:43 INFO - PROCESS | 2514 | RSS: Main: 310083584 07:15:43 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | Cycle 1(1): loaded http://localhost:64515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64515/tests/kraken/driver.html?testName=ai-astar) 07:15:45 INFO - PROCESS | 2514 | RSS: Main: 354099200 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | __start_tp_report 07:15:45 INFO - PROCESS | 2514 | _x_x_mozilla_page_load 07:15:45 INFO - PROCESS | 2514 | _x_x_mozilla_page_load_details 07:15:45 INFO - PROCESS | 2514 | |i|pagename|runs| 07:15:45 INFO - PROCESS | 2514 | |0;ai-astar;116;112;112;112;113;112;112;113;111;113 07:15:45 INFO - PROCESS | 2514 | |1;audio-beat-detection;145;110;109;142;109;108;108;108;141;106 07:15:45 INFO - PROCESS | 2514 | |2;audio-dft;186;182;183;184;184;185;183;182;185;186 07:15:45 INFO - PROCESS | 2514 | |3;audio-fft;83;60;58;90;61;76;82;83;90;57 07:15:45 INFO - PROCESS | 2514 | |4;audio-oscillator;91;71;94;71;68;69;92;68;69;89 07:15:45 INFO - PROCESS | 2514 | |5;imaging-gaussian-blur;89;85;88;86;91;84;89;86;90;83 07:15:45 INFO - PROCESS | 2514 | |6;imaging-darkroom;92;93;93;92;92;94;92;93;93;93 07:15:45 INFO - PROCESS | 2514 | |7;imaging-desaturate;85;115;131;105;84;84;84;96;132;118 07:15:45 INFO - PROCESS | 2514 | |8;json-parse-financial;56;53;53;56;57;59;58;58;58;58 07:15:45 INFO - PROCESS | 2514 | |9;json-stringify-tinderbox;66;78;71;84;74;72;71;74;74;74 07:15:45 INFO - PROCESS | 2514 | |10;stanford-crypto-aes;83;85;82;82;85;80;81;83;89;89 07:15:45 INFO - PROCESS | 2514 | |11;stanford-crypto-ccm;146;149;156;138;136;138;140;139;170;136 07:15:45 INFO - PROCESS | 2514 | |12;stanford-crypto-pbkdf2;163;167;165;165;167;167;166;162;169;162 07:15:45 INFO - PROCESS | 2514 | |13;stanford-crypto-sha256-iterative;67;68;68;65;67;69;68;67;67;69 07:15:45 INFO - PROCESS | 2514 | __end_tp_report 07:15:45 INFO - PROCESS | 2514 | __start_cc_report 07:15:45 INFO - PROCESS | 2514 | _x_x_mozilla_cycle_collect,1984 07:15:45 INFO - PROCESS | 2514 | __end_cc_report 07:15:45 INFO - PROCESS | 2514 | __startTimestamp1479136545713__endTimestamp 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | ------- Summary: start ------- 07:15:45 INFO - PROCESS | 2514 | Number of tests: 14 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:1.35 (1.2%) stddev-sans-first:0.67 07:15:45 INFO - PROCESS | 2514 | Values: 116.0 112.0 112.0 112.0 113.0 112.0 112.0 113.0 111.0 113.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:109.50 stddev:16.67 (15.2%) stddev-sans-first:14.69 07:15:45 INFO - PROCESS | 2514 | Values: 145.0 110.0 109.0 142.0 109.0 108.0 108.0 108.0 141.0 106.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.49 (0.8%) stddev-sans-first:1.39 07:15:45 INFO - PROCESS | 2514 | Values: 186.0 182.0 183.0 184.0 184.0 185.0 183.0 182.0 185.0 186.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#3] audio-fft Cycles:10 Average:74.00 Median:82.50 stddev:13.55 (16.4%) stddev-sans-first:13.97 07:15:45 INFO - PROCESS | 2514 | Values: 83.0 60.0 58.0 90.0 61.0 76.0 82.0 83.0 90.0 57.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:80.00 stddev:11.55 (14.4%) stddev-sans-first:11.29 07:15:45 INFO - PROCESS | 2514 | Values: 91.0 71.0 94.0 71.0 68.0 69.0 92.0 68.0 69.0 89.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.50 stddev:2.69 (3.0%) stddev-sans-first:2.76 07:15:45 INFO - PROCESS | 2514 | Values: 89.0 85.0 88.0 86.0 91.0 84.0 89.0 86.0 90.0 83.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 07:15:45 INFO - PROCESS | 2514 | Values: 92.0 93.0 93.0 92.0 92.0 94.0 92.0 93.0 93.0 93.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#7] imaging-desaturate Cycles:10 Average:103.40 Median:84.00 stddev:19.59 (23.3%) stddev-sans-first:19.61 07:15:45 INFO - PROCESS | 2514 | Values: 85.0 115.0 131.0 105.0 84.0 84.0 84.0 96.0 132.0 118.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:2.12 (3.7%) stddev-sans-first:2.24 07:15:45 INFO - PROCESS | 2514 | Values: 56.0 53.0 53.0 56.0 57.0 59.0 58.0 58.0 58.0 58.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:74.00 stddev:4.73 (6.4%) stddev-sans-first:4.09 07:15:45 INFO - PROCESS | 2514 | Values: 66.0 78.0 71.0 84.0 74.0 72.0 71.0 74.0 74.0 74.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:3.11 (3.7%) stddev-sans-first:3.28 07:15:45 INFO - PROCESS | 2514 | Values: 83.0 85.0 82.0 82.0 85.0 80.0 81.0 83.0 89.0 89.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:143.00 stddev:10.97 (7.7%) stddev-sans-first:11.63 07:15:45 INFO - PROCESS | 2514 | Values: 146.0 149.0 156.0 138.0 136.0 138.0 140.0 139.0 170.0 136.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:2.36 (1.4%) stddev-sans-first:2.35 07:15:45 INFO - PROCESS | 2514 | Values: 163.0 167.0 165.0 165.0 167.0 167.0 166.0 162.0 169.0 162.0 07:15:45 INFO - PROCESS | 2514 | 07:15:45 INFO - PROCESS | 2514 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 07:15:45 INFO - PROCESS | 2514 | Values: 67.0 68.0 68.0 65.0 67.0 69.0 68.0 67.0 67.0 69.0 07:15:45 INFO - PROCESS | 2514 | -------- Summary: end -------- 07:15:45 INFO - PROCESS | 2514 | 07:15:46 INFO - TEST-INFO | 2514: exit 0 07:15:46 INFO - TEST-OK | kraken | took 58711ms 07:15:46 INFO - SUITE-END | took 1175s 07:15:46 INFO - Completed test suite (00:19:36) 07:15:46 INFO - javascript benchmark 07:15:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.789348692335, 3251.089694885432, 3257.2671148991467, 3293.440115180419, 3311.652276510966, 5570.387257401688, 5593.188987596796, 5611.3266408031095, 5631.127175287832, 5649.322081350244, 5571.554275657948, 5636.070048442002, 5641.746121424536, 5650.0, 5710.172025056375, 5091.516305950938, 5119.718415487147, 5129.433845478061, 5136.306598609196, 5188.558972487343, 5083.237514372855, 5129.666571672848, 5213.869653258661, 5231.424543300253, 5279.234510995903, 4219.620234178923, 5121.206213036985, 5126.641135120524, 5162.070827251093, 5194.27280180775, 5118.181091025437, 5134.717590532519, 5171.689698618095, 5219.791208351661, 5223.268742376033, 5105.106606343875, 5158.226266060084, 5167.638265321429, 5176.378834539842, 5201.08980928336, 5422.213779002062, 5476.397596264408, 5482.698451585161, 5496.31296087989, 5587.329520457572, 6079.422454866781, 6143.98624227002, 6148.600340977822, 6160.630362178284, 6175.722092505848, 6153.230846144232, 6236.18929539157, 6255.06174073888, 6264.749410023594, 6267.9686601567155, 5148.176291793295, 5237.795307079393, 5589.524890384363, 5699.401562835926, 5761.884762304772, 6175.197224360804, 6253.96873015632, 6309.747610095545, 6318.178636777281, 6325.272593651697, 6077.270727512639, 6085.366096101532, 6092.39076092396, 6106.755729770848, 6124.0, 6136.592867771182, 6152.907706384408, 6230.719617617218, 6231.750729970841, 6239.282482514569, 4957.925631115536, 5920.31916329619, 5996.760129594854, 6009.909851352233, 6084.209052823193, 6151.138840562325, 6151.292601350812, 6172.043333283348, 6177.0, 6193.163922870445, 4842.661013729005, 4866.221404575322, 4866.221404575322, 4870.025994801054, 4892.68197567157, 4333.913321733611, 4334.393184954109, 4357.150355680612, 4372.868813935587, 4400.537943515948, 4726.740029298421, 5580.135079062752, 5671.376148623648, 5682.0, 5699.515541178963, 6130.275842464065, 6256.0, 6257.0, 6264.5301602380005, 6277.497800175975, 5621.8594535136135, 5686.77252909879, 5699.059655156935, 5701.657900525982, 5709.7716091356715, 5220.295260139908, 5286.444923283077, 5346.4118946915805, 5357.383900851374, 5360.981413531416, 6257.2491301044165, 6303.117563541016, 6315.431611155018, 6326.6836658165985, 6328.746850125944, 6101.389861013863, 6135.477655820289, 6149.524114212646, 6257.4994000480765, 6258.311585725475, 6235.563510554399, 6280.371962803683, 6310.558260921692, 6313.273973492924, 6313.842153946004, 5874.882502350015, 6060.848478788065, 6083.847903802441, 6097.75608975636, 6111.083337499233, 6068.726907289094, 6099.176611157437, 6110.224634763396, 6120.843333897588, 6146.170267014075, 6019.187409699634, 6028.125921741411, 6029.0, 6044.848878778066, 6075.2405949256345, 5828.358880523224, 5938.168656388023, 6003.129546215687, 6018.21763170785, 6036.456718895145, 5697.914531282117, 5729.828105156852, 5743.224664670216, 5856.736446859987, 5866.853328666647, 5948.048312270016, 5970.0746384310505, 5977.551683623658, 6090.573659843769, 6127.264728232641, 5831.300243970751, 5852.473277404883, 5853.531717462678, 5873.4126587340925, 5911.881762364815], "value": 5610.453336085683, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.9042846216526, 499.9750511451521, 513.4275283059385, 515.4072816261299, 516.5867306155075, 29758.85120574397, 39659.0, 40865.387019194735, 40941.18117637649, 43030.56969430305, 42417.151656966846, 42757.57242427575, 42811.57188428115, 42848.78575607125, 42886.35670464946, 9685.515724213796, 9889.703308900709, 9889.75275618108, 9898.50507474627, 9928.255380846465, 9653.27600429967, 9768.023197680246, 9777.217822574177, 9781.902180978206, 9787.46168960707, 9587.13715765581, 9728.854067188999, 9790.90209097907, 9815.65645202418, 9816.901830981671, 9742.07450292221, 9752.561134748918, 9790.608375664964, 9790.657326993593, 9806.705798826082, 9701.6604418845, 9775.51122443882, 9788.853167202498, 9791.902080979171, 9816.361936474106, 40189.0, 40541.59458405407, 40552.391714124315, 40572.188556229004, 40606.0, 3250.2686895448574, 3586.5337506124297, 3598.1004748812798, 3785.5078839750654, 3851.0757418219705, 29538.0, 30786.23034424135, 31358.216044599067, 32009.679903200904, 32461.0, 3103.286244163832, 3153.1013661106704, 3201.9039428817173, 3404.7616666833333, 3416.538767266412, 476993.0, 482028.0, 484888.0, 485181.0, 486246.0, 59913.40086599165, 60082.69958650179, 60510.69744651337, 60566.0, 60573.69713151406, 65814.67092664506, 65912.67043664752, 65923.67038164778, 66059.6788064236, 66069.0, 14236.932230082784, 16941.23764430579, 17125.22936467862, 17138.885972411754, 17172.96962182273, 13156.881665058385, 13177.802332965013, 13179.60461186166, 13196.406161722745, 13201.339933003312, 16236.75644865328, 18130.546736331435, 18165.819221750546, 18167.273309067754, 18183.909080454512, 5291.920621190685, 6377.362263773585, 6447.774327898501, 6485.578437401554, 6521.0, 898.6135961536471, 983.896690847465, 995.5271246158017, 1020.8672872526524, 1085.7285678580356, 29347.706522934925, 29691.0, 29894.40211195764, 30556.69443305583, 30618.69381306203, 883.7878909061908, 1026.553449249564, 1057.5769692123213, 1076.5424694504804, 1157.9305241685358, 14683.55949321522, 15102.471413500694, 15181.405952374842, 15192.696146077238, 15470.690586188213, 650272.0, 657695.0, 657923.0, 658408.0, 659781.0, 58809.41190588125, 58840.41159588435, 58896.41103588909, 58973.0, 59391.703041484514, 1081.291753901196, 1335.6660834791303, 1383.8339399272152, 1384.2248340928911, 1385.161977003898, 28779.856100719364, 29057.0, 29326.680299386153, 30046.098617041524, 30105.849470752506, 50862.23706644329, 51293.230601541756, 51383.48616513787, 51406.0, 51422.97154056823, 615136.0, 618386.0, 618614.0, 622743.0, 623021.0, 40054.39646422973, 41293.96765080897, 41663.0, 41849.1630167401, 41945.79027104845, 46756.29865552088, 46796.29805552988, 48125.27812082751, 48890.266645999625, 50055.49944500509, 39331.2133757329, 39800.60199398085, 40291.0, 41257.174856503305, 41493.79253103715, 33641.831790840886, 38728.41907371448, 39006.80496597499, 40298.1940361197, 40475.78572642826, 37739.62260377471, 38141.0, 38165.618343816204, 38198.0, 38768.41847372348, 33471.33057338791, 34743.30513389769, 35023.0, 35372.469412958315, 35544.28911421809, 25884.35289117787, 25957.00312794827, 25976.8701156493, 26320.8683956579, 26452.73547264503], "value": 20334.84757636263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.9550662907193, 322.35850657192185, 343.6426116838488, 361.75219974317594, 383.39997903281363, 15219.391224351026, 15680.294386752596, 15853.84146158538, 17898.194581243843, 21196.89401552994, 19738.21047158112, 20710.0, 20925.47686307839, 20978.475538111554, 21185.68221476679, 6774.220964589062, 6794.626295553742, 7132.679029443688, 7136.536125151874, 7139.85720285594, 6944.097267355262, 7101.325374089453, 7122.537035092729, 7122.821929451779, 7133.286671332877, 4611.815527378918, 4695.389599352096, 4979.352684151056, 7117.466190035742, 7551.924480755205, 7623.085229772463, 8205.753827385188, 8210.30212431938, 8220.547869867154, 8225.8354832903, 7705.152433232396, 7831.334336581397, 7833.764987050341, 7850.568218747967, 7854.0, 28152.0, 28193.85903070492, 28716.0, 28919.987800426883, 29136.8543157285, 2416.1664225842055, 2463.97536024641, 2473.060237109905, 2606.713261541229, 3277.0987978306157, 16270.593235169097, 17179.570510737205, 17575.648487030314, 17712.734308985375, 18059.729104063448, 1764.1443899708631, 2041.8774873507637, 2053.4455696961886, 2060.248009476545, 2063.8348932085396, 87086.0, 130682.0, 134497.98253026212, 144134.0, 147079.11683532645, 15561.455349062728, 17769.644607107784, 19427.125779339964, 20020.299289524795, 21473.892630536746, 31141.844290778856, 34316.82841585776, 34964.951051468495, 35193.47209791855, 35217.47173792395, 10556.630517931835, 10854.93756186322, 11004.284721493077, 11023.503942322615, 11178.888211117785, 9034.954825225832, 9052.637894484147, 9098.31762617793, 9230.261579073658, 9255.074492550692, 8300.256946041278, 9164.175224229852, 9448.811023779486, 9663.226941844636, 9710.70867873965, 3721.4603882436895, 3732.8133593320226, 3740.6072362401555, 3821.764267903252, 3871.264459752638, 853.2875049333752, 924.408378637659, 981.5828272983953, 1008.6620981971122, 1034.7568321444455, 20008.099635516435, 21428.678569821466, 21429.0, 21441.46396340104, 21512.892435537724, 944.6032666280179, 950.3395140377371, 975.7463059604412, 985.4383001688968, 991.1872264742842, 9005.909940900638, 10945.616903408343, 11473.885261147281, 11486.368249746343, 11497.482613282422, 604043.979780107, 621713.0, 626408.0, 640198.0, 645102.0, 142605.57394425923, 143350.2832485831, 143457.0, 147684.0, 149451.0, 974.6734843827255, 1009.4548943570389, 1018.6638409324905, 1018.8064267789097, 1024.1141412678128, 18881.0, 19866.90066549658, 20067.899660501604, 20267.898660506602, 20279.898600506902, 55957.58608455852, 58827.0, 59074.0, 59200.40799592121, 59482.70258648679, 82543.0, 84054.0, 85639.57180214059, 86205.0, 88220.0, 7895.84208315842, 7981.241782030698, 8034.47775894565, 8136.959315203386, 8323.583820809057, 10943.781124377627, 11540.769184616429, 12440.129190956908, 12714.491420343084, 13008.934955325163, 10746.194035447217, 10797.784044318912, 10835.837462437912, 11158.832617510581, 11361.091112711129, 5057.747112644427, 7484.812879678052, 10829.079528240189, 10961.342319460859, 11287.604933827277, 10709.90611703833, 10944.507497162487, 10973.012428881439, 11320.320780753182, 11348.659540213806, 7244.927550724426, 7895.171007044178, 7924.524528528076, 8139.4709343892455, 8360.205780450848, 7829.060512738508, 10235.0, 10635.574577016832, 10644.574217031231, 11153.553857845594], "value": 10980.820773577105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.4799904037911, 1473.8968272220943, 1499.8200215974084, 1674.271691814061, 1860.6185731924948, 7786.221377862211, 8397.286230670392, 8666.826663466727, 8866.822663546725, 8871.512066836322, 8808.986966498855, 8895.110488951117, 8897.466152030882, 8898.377113602035, 8930.821383572325, 2379.916702915398, 2408.421978725111, 2409.722881868581, 2415.1909110448023, 2417.359399759065, 2373.7151541815006, 2408.51829634073, 2417.6494408310787, 2421.4672771990136, 2421.539907417594, 2393.7845593896545, 2400.639904014403, 2411.8070554355695, 2422.4186195313173, 2423.866687332196, 2360.8701521416315, 2383.189715496731, 2389.8446600970883, 2391.8804059797026, 2397.4006498375234, 2353.8940747666397, 2372.6678265042906, 2377.869217193054, 2381.666566680666, 2382.1900553811615, 8771.649134034631, 8803.427777194462, 8850.867236991451, 8909.554522273926, 8915.42049766763, 5270.130428479296, 5493.587980901409, 5501.972490137564, 5507.669539827623, 5517.144842549411, 3570.83931223093, 3602.603713591503, 3633.4731463937846, 3676.8896933091783, 3678.528588564569, 957.7979635557331, 1102.189890430541, 1103.5144536403957, 1125.094299089233, 1126.9492872820742, 11781.705457363549, 11878.881211187863, 11935.283882966964, 11945.820812687816, 11975.760484790255, 4472.239719247736, 4526.705764125387, 4696.835610753607, 4708.858734237979, 4718.4809670936165, 9256.305777066747, 9266.583003764847, 9277.211437027794, 9280.582373793195, 9281.164695177466, 5262.1317482615705, 5278.392984806719, 5284.630075894651, 5291.0, 5291.470852914677, 3866.3233934061427, 4164.729292596032, 4367.956320436819, 4562.908741825211, 4935.481774413706, 3813.809309534512, 3852.4028775539837, 3900.4539364488996, 3922.5096862892137, 3931.744436611611, 1179.6461061681462, 1188.6493484422117, 1190.7380376317196, 1197.8502687164105, 1200.5077918053555, 779.2986312318958, 866.2204016385303, 909.8862642169729, 924.5654542365078, 927.9907200928039, 5774.220480235199, 5908.231929849092, 5948.464638182584, 5961.850953726105, 6167.229096362955, 830.2154464031432, 920.1718453391867, 928.8374534456443, 961.1685891703765, 969.0842154164247, 3027.818330900153, 3816.675582575512, 3973.7417067890497, 4007.2786898358577, 4190.141021090669, 10900.0, 10952.3428594283, 11091.112710983101, 11100.167487438475, 11154.274972126786, 10571.894281057244, 10912.0, 11095.72260693489, 11110.388928609003, 11121.499532520895, 8128.471649342774, 8139.511629302261, 8195.180481951757, 8365.539895305817, 8382.07797142314, 5944.64332140073, 6014.939850601613, 6109.480694141048, 6163.260408750979, 6166.907496387647, 9925.454100024568, 10250.718660167478, 10296.948515257376, 10324.174066074846, 10447.738806529593, 9393.233939274025, 9888.703338899844, 10336.741581460523, 10404.959504049535, 10528.526216320131, 6482.985223576325, 7453.068366454193, 7664.463487555818, 7786.0, 7814.6483408247905, 8338.708145214889, 8366.205210504992, 8375.664973401239, 8401.537915414467, 8504.362172836938, 7405.222451642716, 7444.218357072429, 7504.512206706547, 7679.884801727867, 7707.961460192663, 7477.850442991218, 7500.174980752004, 7511.248875112445, 7522.548647080974, 7582.317591416799, 6878.27778083294, 7114.075170227838, 7116.0, 7157.964210179124, 7160.140783106061, 4819.734914579732, 4880.438749543706, 4995.975020124876, 5144.048351055067, 5221.190715439113, 4636.304554316879, 5102.08162530748, 5113.795448182031, 5373.489518495737, 5447.972760136174], "value": 4601.052369364106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.3951641070163, 295.23681283881166, 304.4626234695762, 308.17101995631765, 311.32597925491314, 5141.018209438526, 5215.765290561924, 5272.209168624709, 5297.549708274796, 5297.629165958385, 5009.373828271466, 5149.974250128754, 5202.141646628311, 5222.321098257231, 5232.73836308184, 3987.262356464049, 3992.281389349916, 4000.8399664013405, 4011.8595849145213, 4014.9397759033636, 3997.7401468904427, 3997.880063598082, 4016.819243134066, 4020.939685904699, 4080.10237747695, 3232.4989626607794, 3271.509273608966, 3466.185446420089, 3905.453236546886, 3968.7420317679403, 3612.981935090321, 3934.783586902719, 3947.881563553098, 3952.3281042222893, 3963.9297389704907, 2824.364517983458, 3401.183715908189, 3401.1973653963437, 3409.403354412968, 3420.110771199506, 4322.82708691652, 4413.249747542925, 4776.0, 5071.442141364447, 5072.289879416885, 3917.8236979335998, 4437.977810110961, 4501.527339629357, 4526.434195725535, 4536.2741961286365, 4622.884427889296, 5103.770330335106, 5467.6719396836315, 5480.369757477902, 5516.668999860021, 3136.38840426117, 3733.2906747718116, 3751.9062023449633, 3759.5300587426573, 3771.510253449899, 5416.864578385572, 5440.63984003999, 5651.7456714447535, 5663.366534561449, 5744.569157313176, 3601.37099917062, 3684.502592150079, 3766.3597188478025, 3818.2554401891366, 3828.636279553438, 3544.2734239480847, 3562.928741425209, 3876.402810117228, 3891.747036442622, 3899.200663863901, 3684.4473329000866, 3754.887353379403, 4008.4187792769885, 4525.411696479437, 4577.656675749332, 4916.680415772963, 5233.502817232356, 5463.48096930791, 5503.532199763065, 5525.668459892419, 1085.0993675249524, 1274.4647248155798, 1307.5292894557952, 1311.3902035553513, 1314.9283334082693, 736.5727877830846, 758.8899609556694, 792.6750032486652, 792.9960350198212, 818.9036067666673, 3765.9246815064093, 3810.627594578818, 3841.7118716096406, 4334.461266250499, 4378.605925466723, 3839.7120215983914, 4237.618614324726, 4589.885252868705, 4725.817651378555, 4733.337332773414, 3515.2969406118877, 3726.832292546842, 3775.5091838061426, 4314.203500919171, 4409.2724700424715, 2158.4711745622108, 2325.0469605531434, 2456.9975469992255, 2472.2088931542094, 2485.4159272570932, 4352.891177720582, 4711.434627844681, 4898.0, 4898.657094003457, 4925.620826168679, 3918.0418783818036, 4027.597240275949, 4454.844080457168, 4605.509628112563, 4643.931895664016, 4170.186813571325, 4371.0, 4393.714408563369, 4649.790759415834, 4895.534924182197, 4027.275090483624, 4377.409049778239, 4729.361536192708, 4734.73958932262, 4747.976260118678, 4454.710443821141, 4482.0, 4673.859784206479, 4696.551999680354, 4730.2195137803255, 4620.1221767865345, 4864.416270047617, 4878.390201224847, 5018.924716129188, 5419.458054194549, 3761.2289480656946, 3778.5843557208136, 3796.924061518699, 3814.3134235837815, 3831.731778775459, 4620.353150558857, 5669.54643628517, 5669.886602267849, 5684.459976302244, 5711.086226203787, 5341.996751218293, 5403.756830942696, 5412.890357476629, 5524.66851988882, 5539.667619942817, 5317.282166907573, 5456.2906822114455, 5465.0, 5470.72646367688, 5518.606057274827, 5354.170103633943, 5354.598405119554, 5377.569794416516, 5379.408265090915, 5383.016567739923, 5140.43455219918, 5455.563554915518, 5467.528119644134, 5472.5621950243085, 5590.608657394106, 4508.549145085596, 5354.643956659058, 5354.678719276856, 5381.0, 5385.569154467555], "value": 3776.8757050211066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.6765955320105, 719.9999999999997, 737.3327138939259, 781.3583156727208, 806.850732614466, 16823.074730889795, 17080.316787328524, 17087.401940932068, 17098.91450542747, 17534.736978945293, 16567.50297491074, 16729.832701672978, 16743.497695069138, 16749.330026798943, 16755.66488670226, 675.8715843989626, 694.8228201808532, 820.1306614988117, 852.8720691896234, 860.3547339495378, 683.1904193530657, 824.6495239523209, 830.1947111302028, 843.5782108945527, 843.9240468357847, 892.7946572288345, 897.6947837735169, 898.2275243290765, 899.244634507014, 899.4648184330346, 686.9003994420831, 703.4688809948507, 893.3835653399166, 895.4895709445651, 898.4160295807712, 645.2321737132797, 650.4763665249473, 656.4092316914815, 657.2868437745052, 660.1121491593799, 15612.375504979787, 15653.843461565353, 15655.295511702001, 15657.843421565753, 15659.843401565953, 13426.261555614437, 13654.453821847113, 13766.518171864036, 13805.51680691171, 13982.790258146137, 11226.775464490664, 11714.472848721827, 11727.296362218294, 12231.449584768707, 12331.732090995893, 3770.1140232045445, 3815.2470127873507, 3850.172212974196, 3858.2090671412293, 3947.842086316544, 113556.0, 115635.0, 120194.0, 121072.0, 121607.78392216141, 9500.857487137699, 10766.246362754531, 10853.131749460024, 11095.389753563632, 11247.325160490396, 17996.55008624795, 21644.45888852791, 21662.675059874113, 21905.780942190373, 22054.11783528673, 8042.356611471068, 8064.55644939534, 8101.959490202511, 8139.959300203461, 8214.8357032859, 4178.6448151907425, 4202.726822756511, 4287.721298115613, 4303.612674859278, 4323.308270676676, 3129.921751956174, 3605.0446631642635, 3734.3464893643504, 3739.3456145174487, 3749.9062523436587, 664.3423011218858, 665.6339013542629, 677.7932730517141, 681.6523572977718, 684.5174152222671, 588.4409810679871, 621.9284782250008, 640.3820313397594, 655.7245956698102, 673.2291526202569, 9279.72160835176, 9712.223022158352, 9749.171320437701, 9802.313838031268, 9802.558884850056, 559.1556749308492, 567.5884983387011, 641.6599202422724, 661.4509956735898, 694.4513834071028, 4295.453636690789, 4383.736975781463, 4769.59421069946, 4784.330193772875, 4869.878253043631, 157966.0, 162408.0, 166578.50132248027, 169181.0, 180215.0, 92259.0, 141194.0, 142881.0, 144991.0, 154072.3778286653, 123389.38305308236, 124970.75029249773, 127118.0, 127283.0, 128423.71576284304, 8945.0, 9245.260379169516, 9281.211097056826, 9351.625934962525, 9471.66849160276, 64522.709545807884, 65642.67178664076, 66021.33978660151, 66951.99572006326, 68634.65682671555, 95552.0, 100105.49947250217, 101643.0, 104035.0, 106643.40034899638, 10798.784024319626, 11128.332300062022, 11238.606648767254, 11401.258918170292, 11667.358295293501, 12922.935385323013, 13303.707541623844, 13454.865451345362, 13573.321333933462, 13844.10013349129, 11765.176437649283, 12025.0, 12375.504979800708, 12516.499340026661, 12906.354682266037, 12248.816267756169, 12378.938105309417, 12452.750944980868, 12468.940140088194, 12936.547220847226, 11574.363410012193, 12077.214981026205, 12289.1397602167, 12386.071044671866, 12394.690132746393, 8589.398742087993, 9469.573869176042, 9891.35706179096, 10036.447995360033, 10096.444695541815, 9890.159336456481, 10639.308444951053, 10848.0, 10903.509342079784, 10912.181586381212], "value": 7800.267290789298, "unit": "score"}], "name": "dromaeo_css", "value": 7441.680812617312, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 111.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 109.0, 142.0, 109.0, 108.0, 108.0, 108.0, 141.0, 106.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 184.0, 184.0, 185.0, 183.0, 182.0, 185.0, 186.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 58.0, 90.0, 61.0, 76.0, 82.0, 83.0, 90.0, 57.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 94.0, 71.0, 68.0, 69.0, 92.0, 68.0, 69.0, 89.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 86.0, 91.0, 84.0, 89.0, 86.0, 90.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 92.0, 92.0, 94.0, 92.0, 93.0, 93.0, 93.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 115.0, 131.0, 105.0, 84.0, 84.0, 84.0, 96.0, 132.0, 118.0], "value": 103.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 56.0, 57.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 71.0, 84.0, 74.0, 72.0, 71.0, 74.0, 74.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 82.0, 82.0, 85.0, 80.0, 81.0, 83.0, 89.0, 89.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 156.0, 138.0, 136.0, 138.0, 140.0, 139.0, 170.0, 136.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 165.0, 165.0, 167.0, 167.0, 166.0, 162.0, 169.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 67.0, 69.0, 68.0, 67.0, 67.0, 69.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1442.5, "alertThreshold": 2.0}]} 07:15:46 INFO - Return code: 0 07:15:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:47 INFO - # TBPL SUCCESS # 07:15:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:47 INFO - 2016-11-14 07:15:47.022 screenresolution[2518:35482] starting screenresolution argv=screenresolution get 07:15:47 INFO - 2016-11-14 07:15:47.024 screenresolution[2518:35482] Display 0: 1600x1200x32@60 07:15:47 INFO - 2016-11-14 07:15:47.030 screenresolution[2519:35485] starting screenresolution argv=screenresolution list 07:15:47 INFO - Available Modes on Display 0 07:15:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:47 INFO - Intel Iris: 07:15:47 INFO - Chipset Model: Intel Iris 07:15:47 INFO - Type: GPU 07:15:47 INFO - Bus: Built-In 07:15:47 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:47 INFO - Vendor: Intel (0x8086) 07:15:47 INFO - Device ID: 0x0a2e 07:15:47 INFO - Revision ID: 0x0009 07:15:47 INFO - Displays: 07:15:47 INFO - Display: 07:15:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:47 INFO - Display Serial Number: 1600x1200 60 07:15:47 INFO - Main Display: Yes 07:15:47 INFO - Mirror: Off 07:15:47 INFO - Online: Yes 07:15:47 INFO - Rotation: Supported 07:15:47 INFO - Return code: 0 07:15:47 INFO - Running post-action listener: _resource_record_post_action 07:15:47 INFO - [mozharness: 2016-11-14 15:15:47.265603Z] Finished run-tests step (success) 07:15:47 INFO - Running post-run listener: _resource_record_post_run 07:15:47 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 8192; Write bytes: 665160192; Read time: 0; Write time: 2008 07:15:47 INFO - TinderboxPrint: CPU usage
53.5% 07:15:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 0 07:15:47 INFO - TinderboxPrint: I/O write bytes / time
665,160,192 / 2,008 07:15:47 INFO - TinderboxPrint: CPU idle
2,250.1 (46.5%) 07:15:47 INFO - TinderboxPrint: CPU system
971.2 (20.1%) 07:15:47 INFO - TinderboxPrint: CPU user
1,616.4 (33.4%) 07:15:47 INFO - TinderboxPrint: Swap in / out
363,061,248 / 0 07:15:47 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355531264; Write bytes: 357369856; Read time: 27674; Write time: 682 07:15:47 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 8192; Write bytes: 297628160; Read time: 0; Write time: 1291 07:15:47 INFO - Running post-run listener: _upload_blobber_files 07:15:47 INFO - Blob upload gear active. 07:15:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:47 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 07:15:47 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'] 07:15:47 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 07:15:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:49 INFO - (blobuploader) - INFO - Done attempting. 07:15:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:50 INFO - (blobuploader) - INFO - Done attempting. 07:15:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:52 INFO - (blobuploader) - INFO - Done attempting. 07:15:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:52 INFO - Return code: 0 07:15:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a512c6553f685950cc426b52c4a0696ef792d386242477433a19a58f7ef6d367efe4efd755b356e1ecd03e43885a8eb264b0c9e0f640312ba92e6c40791a6b7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25126e0cf573e8e835945014b29dd98b142217b622f9511c9ef403eaefc0e895b8652f0ee7eaee0b22decc4a369b78605fc4426240b5d9addadc8ffff49ac7f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af081cdfdfa9fa2d94e5ee45f5d6e86631cbcbf69ea55b4ac65990bedf5b6516b3dfa1c916202819ed2ca140e78ce0b2c459722a3f982f69f8a4cc1b2d6a1d49"} 07:15:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:52 INFO - Contents: 07:15:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a512c6553f685950cc426b52c4a0696ef792d386242477433a19a58f7ef6d367efe4efd755b356e1ecd03e43885a8eb264b0c9e0f640312ba92e6c40791a6b7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25126e0cf573e8e835945014b29dd98b142217b622f9511c9ef403eaefc0e895b8652f0ee7eaee0b22decc4a369b78605fc4426240b5d9addadc8ffff49ac7f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af081cdfdfa9fa2d94e5ee45f5d6e86631cbcbf69ea55b4ac65990bedf5b6516b3dfa1c916202819ed2ca140e78ce0b2c459722a3f982f69f8a4cc1b2d6a1d49"} 07:15:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:52 INFO - Copying logs to upload dir... 07:15:52 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.242004 ========= master_lag: 1.43 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-14 07:15:54.061625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:15:54.066840) ========= 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.3mZIPqYIus/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.2nkPsVoh8b/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/a512c6553f685950cc426b52c4a0696ef792d386242477433a19a58f7ef6d367efe4efd755b356e1ecd03e43885a8eb264b0c9e0f640312ba92e6c40791a6b7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25126e0cf573e8e835945014b29dd98b142217b622f9511c9ef403eaefc0e895b8652f0ee7eaee0b22decc4a369b78605fc4426240b5d9addadc8ffff49ac7f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af081cdfdfa9fa2d94e5ee45f5d6e86631cbcbf69ea55b4ac65990bedf5b6516b3dfa1c916202819ed2ca140e78ce0b2c459722a3f982f69f8a4cc1b2d6a1d49"} build_url:https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.012183 build_url: 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/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/a512c6553f685950cc426b52c4a0696ef792d386242477433a19a58f7ef6d367efe4efd755b356e1ecd03e43885a8eb264b0c9e0f640312ba92e6c40791a6b7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25126e0cf573e8e835945014b29dd98b142217b622f9511c9ef403eaefc0e895b8652f0ee7eaee0b22decc4a369b78605fc4426240b5d9addadc8ffff49ac7f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af081cdfdfa9fa2d94e5ee45f5d6e86631cbcbf69ea55b4ac65990bedf5b6516b3dfa1c916202819ed2ca140e78ce0b2c459722a3f982f69f8a4cc1b2d6a1d49"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:15:54.104877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-14 07:15:54.105156) ========= 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.3mZIPqYIus/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.2nkPsVoh8b/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005361 ========= master_lag: 3.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-14 07:15:57.262165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:15:57.262441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:15:57.268040) ========= ========= Total master_lag: 4.68 =========