builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1475003326.3 results: success (0) buildid: 20160927095520 builduid: 0558f31dbbb64835a579184a04f9ab74 revision: 21edb0642a6af3b1a7e5718c729efbb75705c885 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.304035) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.304512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.304802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.329612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.330067) ========= 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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-09-27 12:08:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.6M=0.001s 2016-09-27 12:08:46 (16.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.353550 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.706604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.706978) ========= 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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.027223 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:46.755463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 12:08:46.755847) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 21edb0642a6af3b1a7e5718c729efbb75705c885 --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 21edb0642a6af3b1a7e5718c729efbb75705c885 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CZTpLFGsYR/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.R9pzcGkMmf/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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-09-27 12:08:46,832 truncating revision to first 12 chars 2016-09-27 12:08:46,832 Setting DEBUG logging. 2016-09-27 12:08:46,832 attempt 1/10 2016-09-27 12:08:46,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/21edb0642a6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 12:08:47,494 unpacking tar archive at: mozilla-aurora-21edb0642a6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.163858 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 12:08:47.941153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:47.941456) ========= script_repo_revision: 21edb0642a6af3b1a7e5718c729efbb75705c885 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:47.941851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:47.942115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:08:47.960210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-27 12:08:47.960494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CZTpLFGsYR/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.R9pzcGkMmf/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:08:48 INFO - MultiFileLogger online at 20160927 12:08:48 in /builds/slave/test 12:08:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:08:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:48 INFO - {'append_to_log': False, 12:08:48 INFO - 'base_work_dir': '/builds/slave/test', 12:08:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:08:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:48 INFO - 'branch': 'Mozilla-Aurora', 12:08:48 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:48 INFO - 'config_files': ('talos/mac_config.py',), 12:08:48 INFO - 'default_actions': ('clobber', 12:08:48 INFO - 'read-buildbot-config', 12:08:48 INFO - 'download-and-extract', 12:08:48 INFO - 'populate-webroot', 12:08:48 INFO - 'create-virtualenv', 12:08:48 INFO - 'install', 12:08:48 INFO - 'run-tests'), 12:08:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:48 INFO - 'download_minidump_stackwalk': True, 12:08:48 INFO - 'download_symbols': 'ondemand', 12:08:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:48 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:48 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:48 INFO - 'installer_path': 'installer.exe', 12:08:48 INFO - 'log_level': 'info', 12:08:48 INFO - 'log_name': 'talos', 12:08:48 INFO - 'log_to_console': True, 12:08:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:08:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:08:48 INFO - 'opt_config_files': (), 12:08:48 INFO - 'pip_index': False, 12:08:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:48 INFO - 'cmd': ('bash', 12:08:48 INFO - '-c', 12:08:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:48 INFO - 'enabled': True, 12:08:48 INFO - 'halt_on_failure': False, 12:08:48 INFO - 'name': 'check_screen_resolution'},), 12:08:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:48 INFO - 'cmd': ('bash', 12:08:48 INFO - '-c', 12:08:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:48 INFO - 'enabled': True, 12:08:48 INFO - 'halt_on_failure': False, 12:08:48 INFO - 'name': 'check_screen_resolution'},), 12:08:48 INFO - 'run_cmd_checks_enabled': True, 12:08:48 INFO - 'sps_profile': False, 12:08:48 INFO - 'sps_profile_interval': 0, 12:08:48 INFO - 'suite': 'dromaeojs', 12:08:48 INFO - 'system_bits': '32', 12:08:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:48 INFO - 'title': 't-yosemite-r7-0028', 12:08:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:48 INFO - 'use_talos_json': True, 12:08:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:48 INFO - 'work_dir': 'build'} 12:08:48 INFO - [mozharness: 2016-09-27 19:08:48.160888Z] Running clobber step. 12:08:48 INFO - Running pre-action listener: _resource_record_pre_action 12:08:48 INFO - Running main action method: clobber 12:08:48 INFO - rmtree: /builds/slave/test/build 12:08:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:50 INFO - Running post-action listener: _resource_record_post_action 12:08:50 INFO - [mozharness: 2016-09-27 19:08:50.401097Z] Finished clobber step (success) 12:08:50 INFO - [mozharness: 2016-09-27 19:08:50.401229Z] Running read-buildbot-config step. 12:08:50 INFO - Running pre-action listener: _resource_record_pre_action 12:08:50 INFO - Running main action method: read_buildbot_config 12:08:50 INFO - Using buildbot properties: 12:08:50 INFO - { 12:08:50 INFO - "project": "", 12:08:50 INFO - "product": "firefox", 12:08:50 INFO - "script_repo_revision": "production", 12:08:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:08:50 INFO - "repository": "", 12:08:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:08:50 INFO - "buildid": "20160927095520", 12:08:50 INFO - "pgo_build": "False", 12:08:50 INFO - "basedir": "/builds/slave/test", 12:08:50 INFO - "buildnumber": 17, 12:08:50 INFO - "slavename": "t-yosemite-r7-0028", 12:08:50 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 12:08:50 INFO - "platform": "yosemite_r7", 12:08:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:08:50 INFO - "branch": "mozilla-aurora", 12:08:50 INFO - "repo_path": "releases/mozilla-aurora", 12:08:50 INFO - "revision": "21edb0642a6af3b1a7e5718c729efbb75705c885", 12:08:50 INFO - "stage_platform": "macosx64", 12:08:50 INFO - "builduid": "0558f31dbbb64835a579184a04f9ab74", 12:08:50 INFO - "slavebuilddir": "test" 12:08:50 INFO - } 12:08:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:08:50 INFO - Running post-action listener: _resource_record_post_action 12:08:50 INFO - [mozharness: 2016-09-27 19:08:50.404304Z] Finished read-buildbot-config step (success) 12:08:50 INFO - [mozharness: 2016-09-27 19:08:50.404400Z] Running download-and-extract step. 12:08:50 INFO - Running pre-action listener: _resource_record_pre_action 12:08:50 INFO - Running main action method: download_and_extract 12:08:50 INFO - mkdir: /builds/slave/test/build/tests 12:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:50 INFO - trying https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:08:50 INFO - Downloading https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 12:08:51 INFO - Downloaded 1199 bytes. 12:08:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:08:51 INFO - Using the following test package requirements: 12:08:51 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:08:51 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:08:51 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:08:51 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'jsshell-mac.zip'], 12:08:51 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:08:51 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:08:51 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:08:51 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:08:51 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:08:51 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:51 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:08:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:08:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:08:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:08:51 INFO - Fetch https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:08:52 INFO - Expected file size: 16432004 12:08:59 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:08:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:08:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:08:59 INFO - Fetch https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:09:01 INFO - Expected file size: 16432004 12:09:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:09:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:09:08 INFO - Fetch https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:09:08 INFO - Expected file size: 14414059 12:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:09 INFO - trying https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:09:09 INFO - Downloading https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 12:09:12 INFO - Downloaded 115276401 bytes. 12:09:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:09:12 INFO - mkdir: /builds/slave/test/properties 12:09:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:09:12 INFO - Writing to file /builds/slave/test/properties/build_url 12:09:12 INFO - Contents: 12:09:12 INFO - build_url:https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:09:13 INFO - Running post-action listener: _resource_record_post_action 12:09:13 INFO - Running post-action listener: set_extra_try_arguments 12:09:13 INFO - [mozharness: 2016-09-27 19:09:13.723523Z] Finished download-and-extract step (success) 12:09:13 INFO - [mozharness: 2016-09-27 19:09:13.723646Z] Running populate-webroot step. 12:09:13 INFO - Running pre-action listener: _resource_record_pre_action 12:09:13 INFO - Running main action method: populate_webroot 12:09:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:09:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:09:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:09:13 INFO - '--tppagecycles', 12:09:13 INFO - '7'], 12:09:13 INFO - 'tests': ['tsvgm']}}, 12:09:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:09:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:09:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:09:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:09:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['damp', 'tps']}, 12:09:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'tests': ['damp', 'tps']}, 12:09:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['dromaeo_dom']}, 12:09:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:09:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['basic_compositor_video']}, 12:09:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:09:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['a11yr', 12:09:13 INFO - 'ts_paint', 12:09:13 INFO - 'tpaint', 12:09:13 INFO - 'sessionrestore', 12:09:13 INFO - 'sessionrestore_no_auto_restore', 12:09:13 INFO - 'tabpaint']}, 12:09:13 INFO - 'other-e10s': {'tests': ['a11yr', 12:09:13 INFO - 'ts_paint', 12:09:13 INFO - 'tpaint', 12:09:13 INFO - 'sessionrestore', 12:09:13 INFO - 'sessionrestore_no_auto_restore', 12:09:13 INFO - 'tabpaint']}, 12:09:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:09:13 INFO - 'ts_paint', 12:09:13 INFO - 'tpaint', 12:09:13 INFO - 'sessionrestore', 12:09:13 INFO - 'sessionrestore_no_auto_restore', 12:09:13 INFO - 'tabpaint']}, 12:09:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:09:13 INFO - 'ts_paint', 12:09:13 INFO - 'tpaint', 12:09:13 INFO - 'sessionrestore', 12:09:13 INFO - 'sessionrestore_no_auto_restore', 12:09:13 INFO - 'tabpaint']}, 12:09:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['a11yr', 12:09:13 INFO - 'ts_paint', 12:09:13 INFO - 'tpaint', 12:09:13 INFO - 'sessionrestore', 12:09:13 INFO - 'sessionrestore_no_auto_restore', 12:09:13 INFO - 'tabpaint']}, 12:09:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['a11yr', 12:09:13 INFO - 'ts_paint', 12:09:13 INFO - 'tpaint', 12:09:13 INFO - 'sessionrestore', 12:09:13 INFO - 'sessionrestore_no_auto_restore', 12:09:13 INFO - 'tabpaint']}, 12:09:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['tsvgx', 12:09:13 INFO - 'tsvgr_opacity', 12:09:13 INFO - 'tart', 12:09:13 INFO - 'tscrollx', 12:09:13 INFO - 'cart']}, 12:09:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:09:13 INFO - 'tsvgr_opacity', 12:09:13 INFO - 'tart', 12:09:13 INFO - 'tscrollx', 12:09:13 INFO - 'cart']}, 12:09:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'talos_options': ['--disable-e10s'], 12:09:13 INFO - 'tests': ['tp5o']}, 12:09:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'tests': ['tp5o']}, 12:09:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'talos_options': ['--disable-e10s', 12:09:13 INFO - '--xperf_path', 12:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:13 INFO - 'tests': ['tp5n']}, 12:09:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:09:13 INFO - 'talos_options': ['--xperf_path', 12:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:13 INFO - 'tests': ['tp5n']}}, 12:09:13 INFO - 'talos.zip': {'path': '', 12:09:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:09:13 INFO - Running post-action listener: _resource_record_post_action 12:09:13 INFO - [mozharness: 2016-09-27 19:09:13.742370Z] Finished populate-webroot step (success) 12:09:13 INFO - [mozharness: 2016-09-27 19:09:13.742507Z] Running create-virtualenv step. 12:09:13 INFO - Running pre-action listener: _resource_record_pre_action 12:09:13 INFO - Running main action method: create_virtualenv 12:09:13 INFO - Creating virtualenv /builds/slave/test/build/venv 12:09:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:09:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:09:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:09:13 INFO - Using real prefix '/tools/python27' 12:09:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:09:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:09:17 INFO - Installing pip.................done. 12:09:17 INFO - Return code: 0 12:09:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:17 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:17 INFO - 'HOME': '/Users/cltbld', 12:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:17 INFO - 'LOGNAME': 'cltbld', 12:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:17 INFO - 'MOZ_NO_REMOTE': '1', 12:09:17 INFO - 'NO_EM_RESTART': '1', 12:09:17 INFO - 'PAGER': '/bin/cat', 12:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:17 INFO - 'PWD': '/builds/slave/test', 12:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:17 INFO - 'SHELL': '/bin/bash', 12:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:17 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:17 INFO - 'USER': 'cltbld', 12:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:17 INFO - 'XPC_FLAGS': '0x0', 12:09:17 INFO - 'XPC_SERVICE_NAME': '0', 12:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:09:17 INFO - Cleaning up... 12:09:17 INFO - Return code: 0 12:09:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:17 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:17 INFO - 'HOME': '/Users/cltbld', 12:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:17 INFO - 'LOGNAME': 'cltbld', 12:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:17 INFO - 'MOZ_NO_REMOTE': '1', 12:09:17 INFO - 'NO_EM_RESTART': '1', 12:09:17 INFO - 'PAGER': '/bin/cat', 12:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:17 INFO - 'PWD': '/builds/slave/test', 12:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:17 INFO - 'SHELL': '/bin/bash', 12:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:17 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:17 INFO - 'USER': 'cltbld', 12:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:17 INFO - 'XPC_FLAGS': '0x0', 12:09:17 INFO - 'XPC_SERVICE_NAME': '0', 12:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:18 INFO - Downloading/unpacking psutil>=3.1.1 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:09:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:20 INFO - Installing collected packages: psutil 12:09:20 INFO - Running setup.py install for psutil 12:09:20 INFO - building 'psutil._psutil_osx' extension 12:09:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:09:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:09:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:09:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:09:21 INFO - building 'psutil._psutil_posix' extension 12:09:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:09:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:09:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:09:21 INFO - ^ 12:09:21 INFO - 1 warning generated. 12:09:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:21 INFO - Successfully installed psutil 12:09:21 INFO - Cleaning up... 12:09:21 INFO - Return code: 0 12:09:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:09: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 mozsystemmonitor==0.3 12:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:21 INFO - 'HOME': '/Users/cltbld', 12:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:21 INFO - 'LOGNAME': 'cltbld', 12:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:21 INFO - 'MOZ_NO_REMOTE': '1', 12:09:21 INFO - 'NO_EM_RESTART': '1', 12:09:21 INFO - 'PAGER': '/bin/cat', 12:09:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:21 INFO - 'PWD': '/builds/slave/test', 12:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:21 INFO - 'SHELL': '/bin/bash', 12:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:21 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:21 INFO - 'USER': 'cltbld', 12:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:21 INFO - 'XPC_FLAGS': '0x0', 12:09:21 INFO - 'XPC_SERVICE_NAME': '0', 12:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:09:24 INFO - Installing collected packages: mozsystemmonitor 12:09:24 INFO - Running setup.py install for mozsystemmonitor 12:09:24 INFO - Successfully installed mozsystemmonitor 12:09:24 INFO - Cleaning up... 12:09:25 INFO - Return code: 0 12:09:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:09:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:25 INFO - 'HOME': '/Users/cltbld', 12:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:25 INFO - 'LOGNAME': 'cltbld', 12:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:25 INFO - 'MOZ_NO_REMOTE': '1', 12:09:25 INFO - 'NO_EM_RESTART': '1', 12:09:25 INFO - 'PAGER': '/bin/cat', 12:09:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:25 INFO - 'PWD': '/builds/slave/test', 12:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:25 INFO - 'SHELL': '/bin/bash', 12:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:25 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:25 INFO - 'USER': 'cltbld', 12:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:25 INFO - 'XPC_FLAGS': '0x0', 12:09:25 INFO - 'XPC_SERVICE_NAME': '0', 12:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:25 INFO - Downloading/unpacking jsonschema==2.5.1 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09: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 12:09:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:09:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:28 INFO - Downloading functools32-3.2.3-2.tar.gz 12:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:09:28 INFO - warning: no files found matching '*.txt' 12:09:28 INFO - no previously-included directories found matching 'build' 12:09:28 INFO - no previously-included directories found matching 'dist' 12:09:28 INFO - no previously-included directories found matching '.git*' 12:09:28 INFO - Installing collected packages: jsonschema, functools32 12:09:28 INFO - Running setup.py install for functools32 12:09:28 INFO - warning: no files found matching '*.txt' 12:09:28 INFO - no previously-included directories found matching 'build' 12:09:28 INFO - no previously-included directories found matching 'dist' 12:09:28 INFO - no previously-included directories found matching '.git*' 12:09:28 INFO - Successfully installed jsonschema functools32 12:09:28 INFO - Cleaning up... 12:09:28 INFO - Return code: 0 12:09:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:28 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:28 INFO - 'HOME': '/Users/cltbld', 12:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:28 INFO - 'LOGNAME': 'cltbld', 12:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:28 INFO - 'MOZ_NO_REMOTE': '1', 12:09:28 INFO - 'NO_EM_RESTART': '1', 12:09:28 INFO - 'PAGER': '/bin/cat', 12:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:28 INFO - 'PWD': '/builds/slave/test', 12:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:28 INFO - 'SHELL': '/bin/bash', 12:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:28 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:28 INFO - 'USER': 'cltbld', 12:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:28 INFO - 'XPC_FLAGS': '0x0', 12:09:28 INFO - 'XPC_SERVICE_NAME': '0', 12:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:09:28 INFO - Cleaning up... 12:09:28 INFO - Return code: 0 12:09:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:28 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:28 INFO - 'HOME': '/Users/cltbld', 12:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:28 INFO - 'LOGNAME': 'cltbld', 12:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:28 INFO - 'MOZ_NO_REMOTE': '1', 12:09:28 INFO - 'NO_EM_RESTART': '1', 12:09:28 INFO - 'PAGER': '/bin/cat', 12:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:28 INFO - 'PWD': '/builds/slave/test', 12:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:28 INFO - 'SHELL': '/bin/bash', 12:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:28 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:28 INFO - 'USER': 'cltbld', 12:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:28 INFO - 'XPC_FLAGS': '0x0', 12:09:28 INFO - 'XPC_SERVICE_NAME': '0', 12:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:29 INFO - Downloading/unpacking blobuploader==1.2.4 12:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:31 INFO - Downloading blobuploader-1.2.4.tar.gz 12:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:09:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:09:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:32 INFO - Downloading docopt-0.6.1.tar.gz 12:09:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:09:32 INFO - Installing collected packages: blobuploader, requests, docopt 12:09:32 INFO - Running setup.py install for blobuploader 12:09:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:09:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:09:33 INFO - Running setup.py install for requests 12:09:33 INFO - Running setup.py install for docopt 12:09:33 INFO - Successfully installed blobuploader requests docopt 12:09:33 INFO - Cleaning up... 12:09:33 INFO - Return code: 0 12:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:33 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:33 INFO - 'HOME': '/Users/cltbld', 12:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:33 INFO - 'LOGNAME': 'cltbld', 12:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:33 INFO - 'MOZ_NO_REMOTE': '1', 12:09:33 INFO - 'NO_EM_RESTART': '1', 12:09:33 INFO - 'PAGER': '/bin/cat', 12:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:33 INFO - 'PWD': '/builds/slave/test', 12:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:33 INFO - 'SHELL': '/bin/bash', 12:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:33 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:33 INFO - 'USER': 'cltbld', 12:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:33 INFO - 'XPC_FLAGS': '0x0', 12:09:33 INFO - 'XPC_SERVICE_NAME': '0', 12:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-g5HGLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-d75XVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-mWsVsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-vmNUe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-A5shjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xblLuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qUjm3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-C3vBBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-adKWcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-oD9odH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4CUaJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-T2mGXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pQq9JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-swmNL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UqNweu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-R59ELq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-aZ6Po4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:09:35 INFO - Running setup.py install for manifestparser 12:09:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:09:35 INFO - Running setup.py install for mozcrash 12:09:36 INFO - Running setup.py install for mozdebug 12:09:36 INFO - Running setup.py install for mozdevice 12:09:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Running setup.py install for mozfile 12:09:36 INFO - Running setup.py install for mozhttpd 12:09:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Running setup.py install for mozinfo 12:09:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Running setup.py install for mozInstall 12:09:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:09:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Running setup.py install for mozleak 12:09:37 INFO - Running setup.py install for mozlog 12:09:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Running setup.py install for moznetwork 12:09:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Running setup.py install for mozprocess 12:09:37 INFO - Running setup.py install for mozprofile 12:09:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Running setup.py install for mozrunner 12:09:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:09:37 INFO - Running setup.py install for mozscreenshot 12:09:38 INFO - Running setup.py install for moztest 12:09:38 INFO - Running setup.py install for mozversion 12:09:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:09:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:09:38 INFO - Cleaning up... 12:09:38 INFO - Return code: 0 12:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:38 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:38 INFO - 'HOME': '/Users/cltbld', 12:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:38 INFO - 'LOGNAME': 'cltbld', 12:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:38 INFO - 'MOZ_NO_REMOTE': '1', 12:09:38 INFO - 'NO_EM_RESTART': '1', 12:09:38 INFO - 'PAGER': '/bin/cat', 12:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:38 INFO - 'PWD': '/builds/slave/test', 12:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:38 INFO - 'SHELL': '/bin/bash', 12:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:38 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:38 INFO - 'USER': 'cltbld', 12:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:38 INFO - 'XPC_FLAGS': '0x0', 12:09:38 INFO - 'XPC_SERVICE_NAME': '0', 12:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:38 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rBfzip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:38 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-HSTQ9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:38 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-bZQlka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-SnMAed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qV7Goa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-YwW_pF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xG9tly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-j9WDcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Pcd7zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-vXiQX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OCF_M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:39 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-uG4HBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:40 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-lJ5IjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:40 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pS0e69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:40 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jxEhX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:40 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-akWyo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:40 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4qziBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:43 INFO - Downloading blessings-1.6.tar.gz 12:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:09:43 INFO - Installing collected packages: blessings 12:09:43 INFO - Running setup.py install for blessings 12:09:43 INFO - Successfully installed blessings 12:09:43 INFO - Cleaning up... 12:09:43 INFO - Return code: 0 12:09:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:44 INFO - Reading from file tmpfile_stdout 12:09:44 INFO - Current package versions: 12:09:44 INFO - blessings == 1.6 12:09:44 INFO - blobuploader == 1.2.4 12:09:44 INFO - docopt == 0.6.1 12:09:44 INFO - functools32 == 3.2.3-2 12:09:44 INFO - jsonschema == 2.5.1 12:09:44 INFO - manifestparser == 1.1 12:09:44 INFO - mozInstall == 1.12 12:09:44 INFO - mozcrash == 0.17 12:09:44 INFO - mozdebug == 0.1 12:09:44 INFO - mozdevice == 0.48 12:09:44 INFO - mozfile == 1.2 12:09:44 INFO - mozhttpd == 0.7 12:09:44 INFO - mozinfo == 0.9 12:09:44 INFO - mozleak == 0.1 12:09:44 INFO - mozlog == 3.4 12:09:44 INFO - moznetwork == 0.27 12:09:44 INFO - mozprocess == 0.23 12:09:44 INFO - mozprofile == 0.28 12:09:44 INFO - mozrunner == 6.12 12:09:44 INFO - mozscreenshot == 0.1 12:09:44 INFO - mozsystemmonitor == 0.3 12:09:44 INFO - moztest == 0.7 12:09:44 INFO - mozversion == 1.4 12:09:44 INFO - psutil == 3.1.1 12:09:44 INFO - requests == 1.2.3 12:09:44 INFO - wsgiref == 0.1.2 12:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:44 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 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:44 INFO - 'HOME': '/Users/cltbld', 12:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:44 INFO - 'LOGNAME': 'cltbld', 12:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:44 INFO - 'MOZ_NO_REMOTE': '1', 12:09:44 INFO - 'NO_EM_RESTART': '1', 12:09:44 INFO - 'PAGER': '/bin/cat', 12:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:44 INFO - 'PWD': '/builds/slave/test', 12:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:44 INFO - 'SHELL': '/bin/bash', 12:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:44 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:44 INFO - 'USER': 'cltbld', 12:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:44 INFO - 'XPC_FLAGS': '0x0', 12:09:44 INFO - 'XPC_SERVICE_NAME': '0', 12:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:09:44 INFO - Cleaning up... 12:09:44 INFO - Return code: 0 12:09:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ed2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1404d7de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, '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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:44 INFO - 'HOME': '/Users/cltbld', 12:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:44 INFO - 'LOGNAME': 'cltbld', 12:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:44 INFO - 'MOZ_NO_REMOTE': '1', 12:09:44 INFO - 'NO_EM_RESTART': '1', 12:09:44 INFO - 'PAGER': '/bin/cat', 12:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:44 INFO - 'PWD': '/builds/slave/test', 12:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:44 INFO - 'SHELL': '/bin/bash', 12:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:09:44 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:44 INFO - 'USER': 'cltbld', 12:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:44 INFO - 'XPC_FLAGS': '0x0', 12:09:44 INFO - 'XPC_SERVICE_NAME': '0', 12:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:09:44 INFO - Cleaning up... 12:09:44 INFO - Return code: 0 12:09:44 INFO - Running post-action listener: _resource_record_post_action 12:09:44 INFO - Running post-action listener: _start_resource_monitoring 12:09:44 INFO - Starting resource monitoring. 12:09:44 INFO - [mozharness: 2016-09-27 19:09:44.915603Z] Finished create-virtualenv step (success) 12:09:44 INFO - [mozharness: 2016-09-27 19:09:44.916628Z] Running install step. 12:09:44 INFO - Running pre-action listener: _resource_record_pre_action 12:09:44 INFO - Running main action method: install 12:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:45 INFO - Reading from file tmpfile_stdout 12:09:45 INFO - Detecting whether we're running mozinstall >=1.0... 12:09:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:09:45 INFO - Reading from file tmpfile_stdout 12:09:45 INFO - Output received: 12:09:45 INFO - Usage: mozinstall [options] installer 12:09:45 INFO - Options: 12:09:45 INFO - -h, --help show this help message and exit 12:09:45 INFO - -d DEST, --destination=DEST 12:09:45 INFO - Directory to install application into. [default: 12:09:45 INFO - "/builds/slave/test"] 12:09:45 INFO - --app=APP Application being installed. [default: firefox] 12:09:45 INFO - mkdir: /builds/slave/test/build/application 12:09:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:10:17 INFO - Reading from file tmpfile_stdout 12:10:17 INFO - Output received: 12:10:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:10:17 INFO - Running post-action listener: _resource_record_post_action 12:10:17 INFO - [mozharness: 2016-09-27 19:10:17.840497Z] Finished install step (success) 12:10:17 INFO - [mozharness: 2016-09-27 19:10:17.840607Z] Running run-tests step. 12:10:17 INFO - Running pre-action listener: _resource_record_pre_action 12:10:17 INFO - Running main action method: run_tests 12:10:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:17 INFO - 2016-09-27 12:10:17.856 screenresolution[1646:8147] starting screenresolution argv=screenresolution get 12:10:17 INFO - 2016-09-27 12:10:17.858 screenresolution[1646:8147] Display 0: 1600x1200x32@60 12:10:17 INFO - 2016-09-27 12:10:17.864 screenresolution[1647:8150] starting screenresolution argv=screenresolution list 12:10:17 INFO - Available Modes on Display 0 12:10:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:18 INFO - Intel Iris: 12:10:18 INFO - Chipset Model: Intel Iris 12:10:18 INFO - Type: GPU 12:10:18 INFO - Bus: Built-In 12:10:18 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:18 INFO - Vendor: Intel (0x8086) 12:10:18 INFO - Device ID: 0x0a2e 12:10:18 INFO - Revision ID: 0x0009 12:10:18 INFO - Displays: 12:10:18 INFO - Display: 12:10:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:18 INFO - Display Serial Number: 1600x1200 60 12:10:18 INFO - Main Display: Yes 12:10:18 INFO - Mirror: Off 12:10:18 INFO - Online: Yes 12:10:18 INFO - Rotation: Supported 12:10:18 INFO - Return code: 0 12:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:10:18 INFO - Python 2.7.3 12:10:18 INFO - Return code: 0 12:10:18 INFO - grabbing minidump binary from tooltool 12:10: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')]} 12:10:18 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 0x106ce6d30>, '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 0x106b4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cdeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:10:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:10:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:10:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:10:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:10:18 INFO - Return code: 0 12:10:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:10:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:10:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:10:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:10:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:10:18 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/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:10:18 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/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:10:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CZTpLFGsYR/Render', 12:10:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:18 INFO - 'HOME': '/Users/cltbld', 12:10:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:18 INFO - 'LOGNAME': 'cltbld', 12:10:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:10:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:18 INFO - 'MOZ_NO_REMOTE': '1', 12:10:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:10:18 INFO - 'NO_EM_RESTART': '1', 12:10:18 INFO - 'PAGER': '/bin/cat', 12:10:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:18 INFO - 'PWD': '/builds/slave/test', 12:10:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:10:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:18 INFO - 'SHELL': '/bin/bash', 12:10:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R9pzcGkMmf/Listeners', 12:10:18 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 12:10:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:18 INFO - 'USER': 'cltbld', 12:10:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:18 INFO - 'XPC_FLAGS': '0x0', 12:10:18 INFO - 'XPC_SERVICE_NAME': '0', 12:10:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:18 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/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:10:18 INFO - mozversion application_buildid: 20160927095520 12:10:18 INFO - mozversion application_changeset: 21edb0642a6af3b1a7e5718c729efbb75705c885 12:10:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:10:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:10:18 INFO - mozversion application_name: Firefox 12:10:18 INFO - mozversion application_remotingname: firefox-dev 12:10:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:10:18 INFO - mozversion application_vendor: Mozilla 12:10:18 INFO - mozversion application_version: 51.0a2 12:10:18 INFO - mozversion platform_buildid: 20160927095520 12:10:18 INFO - mozversion platform_changeset: 21edb0642a6af3b1a7e5718c729efbb75705c885 12:10:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:10:18 INFO - mozversion platform_version: 51.0a2 12:10:18 INFO - using testdate: 1475003418 12:10:18 INFO - actual date: 1475003418 12:10:18 INFO - starting webserver on 'localhost:49266' 12:10:18 INFO - SUITE-START | Running 2 tests 12:10:18 INFO - TEST-START | dromaeo_css 12:10:18 INFO - operating with platform_type : mac_ 12:10:18 INFO - Initialising browser for dromaeo_css test... 12:10:18 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpQJRaYa/profile http://localhost:49266/getInfo.html) 12:10:20 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 12:10:20 INFO - PROCESS | 1657 | colorDepth:24 12:10:20 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 12:10:20 INFO - PROCESS | 1657 | __metrics 12:10:21 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:10:21 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:10:21 INFO - TEST-INFO | 1657: exit 0 12:10:21 INFO - Browser initialized. 12:10:21 INFO - Running cycle 1/1 for dromaeo_css test... 12:10:21 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpQJRaYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:33 INFO - PROCESS | 1660 | RSS: Main: 219041792 12:10:33 INFO - PROCESS | 1660 | 12:11:24 INFO - PROCESS | 1660 | 1475003484606 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:13:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 12:13:38 INFO - PROCESS | 1660 | RSS: Main: 369823744 12:13:38 INFO - PROCESS | 1660 | 12:16:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 12:16:42 INFO - PROCESS | 1660 | RSS: Main: 352378880 12:16:42 INFO - PROCESS | 1660 | 12:19:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 12:19:45 INFO - PROCESS | 1660 | RSS: Main: 332025856 12:19:45 INFO - PROCESS | 1660 | 12:22:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 12:22:48 INFO - PROCESS | 1660 | RSS: Main: 348295168 12:22:48 INFO - PROCESS | 1660 | 12:25:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 12:25:52 INFO - PROCESS | 1660 | RSS: Main: 313602048 12:25:52 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 12:28:55 INFO - PROCESS | 1660 | RSS: Main: 486543360 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | __start_tp_report 12:28:55 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 12:28:55 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 12:28:55 INFO - PROCESS | 1660 | |i|pagename|runs| 12:28:55 INFO - PROCESS | 1660 | |0;dojo.html;2826.3923256499875;3297.4064668359697;3317.601887773467;3366.1079813849333;3373.5445714828493;5689;5762.337331206902;5764.971175144118;5802.042662960612;5805.361410244875;5698.43015698431;5769.798057068004;5791.015527360349;5802.071668533035;5803.448672376117;4324.502682191541;5235.816746413876;5255.211718242265;5255.947440525603;5329.413764485923;5210.869728256805;5217.7912883484805;5361.249425080492;5372.2210279509445;5403.78384864605;5254.500822421883;5331.626786124973;5332.706701131437;5344.599155063386;5350;5304.071787437202;5313.840584782462;5325.334333208349;5329.733513324319;5335.093034184198;5160.380754309469;5258.710770907599;5260.789568417297;5265.921011184835;5274.709890955995;5744.540436765049;5814.215080964058;5833.504152147073;5839.124131380285;5845.532357411397;6166.044263139221;6173.166622505949;6185.474234690057;6230.283517395512;6237.719302631393;6261.906071408933;6299.9370006299805;6302.87394252117;6313.87372252557;6317.1156038154695;5847.356790753014;5858.150568167677;5862.438695073795;5868.853278668024;5907.734151963172;6177.598456100339;6218.036204388327;6265.4361107500545;6305.590136641195;6317.842053948596;6125.78490979765;6189.659568723763;6197.504199664016;6203.286622038433;6211.3478084800445;6314.684265786784;6321.525885558602;6328.841778955563;6329.7468101275435;6336.6831658416895;6104.814386015445;6148.1392605035335;6175.135481032659;6241.313455519889;6284.811455656338;6263.279722831841;6322.304546499881;6329.525285603599;6330;6334.968325158345;4971.801127954914;4974.626902982291;4977.676451030671;4980.377452818398;4988.351514303117;4335;4384.780760961939;4405.911881762347;4432.756198409054;4463.486699029589;5906.232189815382;5909.438603332676;5912.556558258148;5925.73334199962;5926;6242.15730876335;6293.1504246927;6299.338569450233;6329.177206963157;6331.810045698637;5664.943350566442;5717.714114294268;5725.799597014167;5746.626469279484;5862.70686465675;5381.0583147948955;5441.809536666197;5459.754311055933;5485.780568777284;5496.6701997880255;5294.179402192666;6349.238091429058;6359.332270111757;6371.23545174582;6372.2034745655865;6117.3576774439825;6291.182146320949;6312.242530896322;6328.493720502441;6332.493400528039;6215.254169499508;6249.1563638908165;6262.436380725574;6320.652364119834;6326.557141000086;6221.253449586078;6263.342349053284;6269.874602507833;6274.435300822948;6275;6239;6240.313565507699;6284.842878928063;6290.779822706183;6298.653574053471;5298.337707786527;6024.156618073385;6093.817185484265;6101;6177.536684748752;6083.574149809471;6161.353057929032;6163.506919446523;6179.073139029181;6210.472109870711;6056.121862330026;6089;6098.725557349841;6104.755809767559;6105.17580126695;5971.313298970674;6036.486898613492;6044.697765111815;6204.410580994799;6204.441600255998;4904.362432883702;5284.365876094893;5613.438656134354;6051.788187413419;6066.545009124245 12:28:55 INFO - PROCESS | 1660 | |1;ext.html;492.3771429142134;496.1763472635426;518.7224834713428;532.0343576408818;549.5658429840427;29747;35662.64337356626;41511;42916.99999999996;44812;36906.630933690656;43970.34044489327;44374.11251774963;44404.777976110076;44632.77683611585;9735.31852770308;9935.652252171176;9950.353227040256;9954.352967057155;9991.450470224136;8874.290056795473;9068.183863452288;9079.046700096495;9222.308326875478;9734.318597698164;9157.084291570856;12155.817662735066;12405.689857753538;12485.313307768069;12650.493980240779;12142.332171730552;12152.966997805108;12179.208351457128;12443.875561244407;12478.688032799162;8834.911650883538;9073;12228.510859565607;12329.136960412774;12331.198472099284;40500.98747531306;41057.38413923793;41069.38395924064;43270.78364608188;43335.78332108351;3367.6295607483157;3500.9649903500895;3559.252556963015;3741.3265612189794;4031.717779755418;31655.683443165504;31761.682383176103;31997.680023199704;32048.839755801306;32275.677243227503;3027.8334691591954;3118.5322201669705;3169.5721077654453;3178.7933784304178;3179.586653735;517571;518724;521435.39282303344;521612;522144;45195.93236608721;55571.44428555744;64416.35583644197;66067.33932660708;67751;67505;68564;68732.3126768736;68777.31222687809;68941;17050.57373565646;17208.65582688339;17226;17229.22468488921;17231.741523877154;13101.951843852468;13148.40832162555;13181.143225690299;13203.801942970864;13320;16800.495985120466;17184.570385740208;17248.741268880978;19532.70700939487;19572;6939.965300173467;7601;7661.233876612406;7812.828075788677;7989.7203597873795;847.4025811802665;935.5789894547481;965.1940629574244;992.7270000749852;1023.9488025598839;29504.81980720747;30335.848320758254;31003;31169;32247.67752322447;1018.8879223285433;1047.8323468245044;1083.9864726480766;1112.9109671226283;1159.2726837012958;14843.960922735521;15543;15696.979696319702;15739.282111425227;15876.444324448588;624530;629735;638371;639973;641342;50842.74578627083;51786.96426071457;51816.48183518192;54529.45470545244;54537.181942270894;1272.7263638317806;1422.9857701423061;1423.38794318442;1445.985540144627;1446.985530144685;28882.711172888;29969.850150749106;32619.34761304808;33729;34115.31769364649;57679;58451;58533.4146658545;58573.5356616088;58599.70700146472;615337;620964;625062;626755;647797;36890.44664330091;43968.78015609901;44157.77921110374;44721.10557788761;44796.32805507985;42188.94527636834;45186.77406612946;48816.511834881196;49091.26363104485;49189.754051229516;39453.605463944994;39771;40173;40457.59542404538;41626;40037.39943900902;40126.3256471946;40577.59422405738;41860.79069604632;41932.37101443542;38344;39002;39764.2047159061;39867.2026559473;40060.399094014196;32209.838950805097;32957;33123;35260;35926.101847454025;26059.08793192229;26067.364087806694;26110.477790443703;26139;26376.340591485365 12:28:55 INFO - PROCESS | 1660 | |2;jquery.html;302.74266873157814;354.519625906896;372.26663472958273;372.9813509324535;406.0964354311657;15112.319945602447;15219.695606087886;16171.757423638655;17092.692486514316;20527.589448211027;19895.602087958232;19919;20445.386638400872;20655.380338589828;20712.378628641127;5955.731992060357;6236.532260080489;6241.251049873998;6249.125122482856;6250.718717657694;4864.416270047599;6188.226471691039;6224.035274532454;6249.687515624223;6257.468115210213;5979.491743201811;6123.908141377883;6205.627662340252;6212.068189771525;6213.533984951124;5261.657992230531;6111.02223644217;6111.480524155408;6165.445109940082;6166.568340216187;5084.720340381277;5252.1596544552685;5323.387810401815;5347.732613369316;5348.652337598043;25574.744252557422;25671.614925776128;25832.225033249033;25897.79868711162;25911.352216194748;2235.083615717548;2244.708187935558;2343.308723926446;2380.9285721428387;2444.669969554105;15247.847521524754;15633.062016278946;15743.606409839846;16046.438374656831;16093.034417934961;1847.9630407391912;1869.7662792150982;1919.779225389084;1921.4139687395339;1932.845372370207;98915.10916246439;100686.49656751669;103498;103858;105865;10517.947410263052;10619.575216991389;10930.453477326102;11045.33727976324;11330.263532870336;11485.310881347146;13585.932070339783;13594;13594.592162235149;13598.864011359958;8590.398672093019;8875.644974200959;8896.644134234559;8962.596683149273;8979.820403592023;8967.542336617362;9000.279977601776;9000.324975626854;9167.862482062774;9171.63313467454;5529.778808847601;6507.739690412331;6588.86822263552;6620.735170593122;6718.0930574372815;1796.7215081662364;1832.9266829326943;1838.1911958738112;1876.2307453943818;1877.9248830046918;855.8074433252593;878.1701292278735;907.8865141857268;923.8429466990627;926.6200857648466;18377.887903957573;20929.58140837205;21982;22014.00936957841;22026.229081982376;901.6610333654518;942.6794889737386;949.1979277510493;962.6871266838166;983.680303901235;9921.851172232422;11398.259113157617;11724.94137529324;11754.647360579196;11823.940880295544;618484;623022.3164293692;630944;632987;635115;110875.44562277298;110950;113884;116274.41862790631;120067;992.7220378294089;1002.8997100289913;1017.6285655735603;1018.3584341864578;1019.4189312092036;19176;19355.4193374199;19745.60508789845;19762.604747904676;19807;49049.26426103683;50880.23679644882;50937.74531127469;51547;53274.73362633162;69741.65129174321;70080;72674.63662681653;72784;73770.63114684392;6559.376859198369;7781.844363112819;7855.33229675484;8007.1592482788465;8318;12863.549775757803;12877.227366358049;13002.414891330101;13372;13415.731685366043;11122.813147320807;11127;11236.381998990135;11473.254238474472;11546.13403994687;10802.567897284021;10963.451827408438;11027.22809403334;11223.775524489627;11427.942860285646;11143.72140696489;11189.496472658913;11249.212555121063;11420.257683250562;11527.827082593936;7820.960895195488;7841.333486653698;7869.960650196713;8133.389995750461;8258.587070646323;11077;11226.607068752555;11414.828777568177;11472.82790758156;11647 12:28:55 INFO - PROCESS | 1660 | |3;mootools.html;1350.1021820489375;1511.0253886243377;1512.992435037825;1718.4758648612176;1886.6226754649065;7198.604076775782;7914.920850791497;8452.957735211323;9024.503652299121;9040.321975851804;8949.149830766082;9012.188902998729;9032.322575806807;9036.41263317884;9044.27645788337;2385.403649087728;2420.177139772477;2420.5279970405777;2421.019487107724;2423.491066875958;2381.297517232412;2400.8319417640773;2426.417659761662;2433.2943446400523;2439.6828412306377;2388.152205966874;2413;2419.5160967806423;2421.116292553223;2421.382547450398;2368.8815559222144;2376.5128148729555;2380.2621187431864;2381.0356805493802;2415.9637605435933;2031.4413536277493;2356.8232382571377;2374.7743964323363;2382.5234953009467;2385.0936644075314;7956.766701161271;8989.37074404792;9010.639574417015;9109.407888487227;9132.771680707969;5183.118869792144;5437.102878025121;5444.754986025639;5486.3690675572025;5487.122060470306;3619.4389869569995;3660.560732712065;3686.668199862025;3733.533308336458;3741.5323084614424;1101.5043230546287;1102.2780079048237;1103.9724006899812;1118.6364431559775;1128.1651577832345;11796.056315494654;11885.108616853771;11904.226225295328;11984.52061917531;11997.160198786089;4476.977615111904;4531.184386810406;4705.788239529229;4713.882152946135;4722.480527142012;9266.258699304039;9282.164605185566;9288.90711092894;9291.024442433447;9298.116678915492;5293.073712100367;5294.41761406245;5299.4700529946695;5302.310699609026;5302.840914772563;4167.687423443193;4409.647228221735;4554.180247555471;4570;4935.629827762932;3784.5836957934607;3826.598207188205;3887.8056097195026;3895.590962948906;3904.1606054698377;1138.1407037686495;1163.9804938431814;1167.4746364136172;1172.8299396587447;1177.617274385828;825.6532256452305;895.1630225738955;905.6513242401722;910.9225715814098;923.9353245272766;5133.589312855037;5366.946330536723;5680.573956953162;5947.49446297061;6006.369331220247;425.19213494360963;440.3043191757016;443.04081663198815;452.3350674508533;452.49094768385567;3400.506926495644;3889.7277190596387;3901.551321597996;3901.668358189586;3999.920001599952;10736.838947415796;11024.44877756125;11121.332720036824;11135.944320278346;11140.888591114148;9432.95283523578;10644.467776611138;10916.727081823017;11081.612143575097;11096.33421994683;8194.22154895284;8305.294050005818;8359.414840961195;8429.777682236165;8441.986961564651;5465.453454654662;5594.888102238014;5679.6876171810945;5901.3213480450295;6002.879942401215;10004.349717268355;10063.849042264519;10188;10291.588336466457;10337.74155646115;10326.01902819231;10379.792404151724;10397.064264216257;10412.583496660352;10527.94736026315;7164.641767911479;7178.497505174588;7247.420206383582;7251.782446526613;7251.927480725336;8342.582870856555;8358.665653373797;8454.196851299117;8471.237588617054;8492.830143397221;7476.738314159196;7600.885986710315;7610.8097297568;7659.502132361602;7738.806529836799;7445.739399121221;7448.627568621656;7480.925190748023;7515.812104697427;7529.171791103084;7051.576905385693;7072.08062951813;7133.928660713534;7157.033800436874;7158.749443769443;5005.049040682259;5005.049040682259;5013.824516142064;5027.371578552681;5058.08954388199;4916.262560615936;4979.103761322996;5085.466026067357;5143;5226.059309324358 12:28:55 INFO - PROCESS | 1660 | |4;prototype.html;250.80437258938028;297.8763813017598;310.0945239899493;314.9354382351618;319.05082379919725;4231.746095234281;4498.932516012263;5330.36035675719;5419.349678038631;5419.945800541994;4512.984578469843;5216.634835561512;5264.473552644734;5289.947100528993;5292.576593872491;4042.7574345539215;4042.777647229394;4076.2866498362814;4079.8572049978256;4119.732217405874;3844.5770965193806;4053.6351728344443;4069.633732964033;4084.1831633673237;4100.220958017967;3522.7005704515145;4014.237294913957;4019.9799001004953;4032.6975476839207;4086.264472394968;4041.1006826791363;4051.6353528182312;4053.310937140693;4055.7363771354917;4058.533268674111;3556.5020897074432;3562.806459835958;3571.196480791827;3574.6782789549065;3582.7671201371827;4250.4899412070445;4653.371794807692;4778.757523043999;5142.665726727751;5191.506806853343;4329.9567004329865;4330.956690433119;4607.516210797851;4638.744869032202;4678.391809064834;4686.250199967989;5199.506046925536;5503.257060296849;5586.301712285965;5593.8321850344555;3197.8081315120935;3746.981265093684;3868.5551161616495;3887.844486220548;3920.313945059632;5766.452187042224;5777.971110144423;5781.942180578182;5799.449052340021;5859.912101318484;3535.805530695785;3674.669279764834;3989.860354887565;3997.920561448451;4011.1949622669918;3392.5759280089987;3899.902502437462;4010.498687664042;4040.373742069984;4050.3924411338535;4508.639308855284;4583.716559363384;4591.612361571963;4600.7929643166135;4687.906241875144;4626.306054091913;5591.46881046308;5599.9920014396985;5649.378568357477;5679.0345641240265;1242.3353505874495;1321.9206847588982;1325.4565628092437;1330.60081975407;1351.8783309502192;772.3782355204114;917.7980844214262;927.4342650982895;929.8558723397749;934.6495064350869;4466.486354069259;5132.204508301219;5203.245529398216;5309.398394786527;5332.346972438479;5601.29983752031;5616.719164041781;5640.971795140998;5668.433156684298;5684.37471878093;4059.5331536873637;4532.4334458192725;4921.803127874845;5083.644144909895;5254.947450525522;2359.4927090675587;2483.503299340139;2485.6644353012475;2496.078019924648;2519.9920031987353;4398.978005109954;4824.662273640882;4834.154023045953;4864.343313652683;4997.800087996439;4213.578642135823;4541.296099104644;4759.547842954914;4771.618270538349;4867.92905560776;4315.4605674290715;4347.782610869507;4656.32483289921;4871.415430148405;4947.441555909877;4335.913281734284;4482.803426321145;4535.863924082283;4811.326414302071;4837.799365681976;3922.843086276517;4056.776877271778;4225.668914291989;4466.731996080245;4519.909601808011;4100.405441210948;4178.435911151955;4857.611391088633;4917.926231106465;4965.503449655005;3242.4812030075077;3400.812955287483;3413.4879768034994;3422.2813209225346;3465.757396982187;4705.576498115186;4746.003339298786;4752.667313288037;4806.49531799156;5432.728363581884;4481.462224533077;4819.2530157825595;5056.873578160576;5436.3476382834315;5643.391633384465;4499.257622492252;5081.221572449613;5539.723013849372;5613.831585052455;5617.213590097308;4975.577075948585;5060.8987820242655;5192.091384007859;5394.892102158014;5531.778728850801;4669.906601867876;5282.234076059027;5675.631083979528;5707.20099186106;5716.256886604715;5357.1696387060065;5526.668399896019;5572.86067848307;5593.804216852391;5621.622702437929 12:28:55 INFO - PROCESS | 1660 | |5;yui.html;704.4047779626216;797.6211299632679;799.7520768561747;806.2461598405488;810.3031393002019;14480.275986200688;17562.73655895161;17799.46601601954;17802.910985445054;17832.28670853166;16595.170241487907;16706.415275465362;16767.496975090737;16778.74831877523;16779.664406711858;661.4576047640936;819.991800081999;848.7114381110421;853.117023880284;853.8420392227458;672.899065140228;685.6503183376489;819.5779173725537;842.5155535567073;849.8427790858711;888.3026823943206;891.0243283604443;891.3760367742574;893.4282059481936;894.6466145872377;888.8622263549096;889.4618755652866;889.8353804546115;891.5987805487524;892.2237653241689;506.68585477004126;519.353405010764;524.2424696313828;525.2829887203977;654.4469922915176;12591.937040314831;12629.305388203646;15047.247637618075;15296.617584560363;15857.60355991098;13952.441902323895;14252.857471425257;14313.212773297464;14338.856611433857;14512.927435362755;11467.139964502612;11770.176087673866;11879.109066820023;11967.880321196764;12026.39868006605;3809.142942837867;3883.0680636647285;3896.1818018215927;3934.3311637021775;3978.204359128157;115632;118669;119760.20359694524;121216;122410;10361.63734269312;10765.946170269099;10802.027817496462;10809.83785243222;11154.996050355507;21932.45168870759;21993.560128797333;22007.2297469591;22198;22200.444988875406;7774.727884524128;7781.455298129076;8018.5990700464745;8144.226298501633;8163.877541836877;4375.47494300686;4410.25025745624;4467.396901418332;4614.238650622677;4688.484266730657;3599.874004409833;3736.925261494755;3740.60723624021;3741.6819570336825;3745.213505163946;651.0657206908102;653.761377097356;662.642173226462;669.2170160911745;673.515069150211;555.8193587084214;578.1616655849035;591.795830438498;641.153677146172;650.5673726971511;7943.4836735612;9008.549572521348;9168.607625111183;9590.616375344907;9619.422834629804;657.3992328679585;660.2341284110408;685.7336502858002;696.6377483708443;705.4497491956282;4572.81708731647;4586.266197408466;4594.540545945379;4596.149712303235;4626.329182268552;176576;176591.11704441396;177457;178446;181191;113564;115032;116596.41701791437;129269;130910.03634945484;89695.65456518157;106120.34699132583;109700;110356;111010.88989110006;8512.616932238188;9199.494027828534;9928.404295742279;9977.700668979942;9978.950105249427;57593;58268.83462330815;58318;59083.70458147682;59833.50416239454;75072;90747.54626226827;94287;96961.51519242358;99120;12818.935905320413;12948.28784416866;13083.215007099605;13149.802752958522;13213;14039.157650541;14295;14559.490417835324;14849.40602375893;15729.528114156594;13341.466341346237;13747.518836840663;14224.288785560888;14750.778738319148;14767.04014239071;13593.184408935496;14187.432502699776;14680;14697.485588004369;14839.258037098318;13541.1198272112;14215.431382744575;14238.430462781373;14266.286685665467;14537.636559086108;11155.609553665583;11519.30884146954;11751.60317238366;11948.761024779282;12281.815772763595;9895.356801807859;11524.481398337262;11634.94182529082;11698.239614425034;11760.58837940668 12:28:55 INFO - PROCESS | 1660 | __end_tp_report 12:28:55 INFO - PROCESS | 1660 | __start_cc_report 12:28:55 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1406 12:28:55 INFO - PROCESS | 1660 | __end_cc_report 12:28:55 INFO - PROCESS | 1660 | __startTimestamp1475004535417__endTimestamp 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | ------- Summary: start ------- 12:28:55 INFO - PROCESS | 1660 | Number of tests: 6 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5769.86 Median:6036.49 stddev:668.18 (11.1%) stddev-sans-first:629.07 12:28:55 INFO - PROCESS | 1660 | Values: 2826.4 3297.4 3317.6 3366.1 3373.5 5689.0 5762.3 5765.0 5802.0 5805.4 5698.4 5769.8 5791.0 5802.1 5803.4 4324.5 5235.8 5255.2 5255.9 5329.4 5210.9 5217.8 5361.2 5372.2 5403.8 5254.5 5331.6 5332.7 5344.6 5350.0 5304.1 5313.8 5325.3 5329.7 5335.1 5160.4 5258.7 5260.8 5265.9 5274.7 5744.5 5814.2 5833.5 5839.1 5845.5 6166.0 6173.2 6185.5 6230.3 6237.7 6261.9 6299.9 6302.9 6313.9 6317.1 5847.4 5858.2 5862.4 5868.9 5907.7 6177.6 6218.0 6265.4 6305.6 6317.8 6125.8 6189.7 6197.5 6203.3 6211.3 6314.7 6321.5 6328.8 6329.7 6336.7 6104.8 6148.1 6175.1 6241.3 6284.8 6263.3 6322.3 6329.5 6330.0 6335.0 4971.8 4974.6 4977.7 4980.4 4988.4 4335.0 4384.8 4405.9 4432.8 4463.5 5906.2 5909.4 5912.6 5925.7 5926.0 6242.2 6293.2 6299.3 6329.2 6331.8 5664.9 5717.7 5725.8 5746.6 5862.7 5381.1 5441.8 5459.8 5485.8 5496.7 5294.2 6349.2 6359.3 6371.2 6372.2 6117.4 6291.2 6312.2 6328.5 6332.5 6215.3 6249.2 6262.4 6320.7 6326.6 6221.3 6263.3 6269.9 6274.4 6275.0 6239.0 6240.3 6284.8 6290.8 6298.7 5298.3 6024.2 6093.8 6101.0 6177.5 6083.6 6161.4 6163.5 6179.1 6210.5 6056.1 6089.0 6098.7 6104.8 6105.2 5971.3 6036.5 6044.7 6204.4 6204.4 4904.4 5284.4 5613.4 6051.8 6066.5 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:73523.35 Median:22102.36 stddev:159233.36 (720.4%) stddev-sans-first:159585.65 12:28:55 INFO - PROCESS | 1660 | Values: 492.4 496.2 518.7 532.0 549.6 29747.0 35662.6 41511.0 42917.0 44812.0 36906.6 43970.3 44374.1 44404.8 44632.8 9735.3 9935.7 9950.4 9954.4 9991.5 8874.3 9068.2 9079.0 9222.3 9734.3 9157.1 12155.8 12405.7 12485.3 12650.5 12142.3 12153.0 12179.2 12443.9 12478.7 8834.9 9073.0 12228.5 12329.1 12331.2 40501.0 41057.4 41069.4 43270.8 43335.8 3367.6 3501.0 3559.3 3741.3 4031.7 31655.7 31761.7 31997.7 32048.8 32275.7 3027.8 3118.5 3169.6 3178.8 3179.6 517571.0 518724.0 521435.4 521612.0 522144.0 45195.9 55571.4 64416.4 66067.3 67751.0 67505.0 68564.0 68732.3 68777.3 68941.0 17050.6 17208.7 17226.0 17229.2 17231.7 13102.0 13148.4 13181.1 13203.8 13320.0 16800.5 17184.6 17248.7 19532.7 19572.0 6940.0 7601.0 7661.2 7812.8 7989.7 847.4 935.6 965.2 992.7 1023.9 29504.8 30335.8 31003.0 31169.0 32247.7 1018.9 1047.8 1084.0 1112.9 1159.3 14844.0 15543.0 15697.0 15739.3 15876.4 624530.0 629735.0 638371.0 639973.0 641342.0 50842.7 51787.0 51816.5 54529.5 54537.2 1272.7 1423.0 1423.4 1446.0 1447.0 28882.7 29969.9 32619.3 33729.0 34115.3 57679.0 58451.0 58533.4 58573.5 58599.7 615337.0 620964.0 625062.0 626755.0 647797.0 36890.4 43968.8 44157.8 44721.1 44796.3 42188.9 45186.8 48816.5 49091.3 49189.8 39453.6 39771.0 40173.0 40457.6 41626.0 40037.4 40126.3 40577.6 41860.8 41932.4 38344.0 39002.0 39764.2 39867.2 40060.4 32209.8 32957.0 33123.0 35260.0 35926.1 26059.1 26067.4 26110.5 26139.0 26376.3 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:34992.36 Median:2412.80 stddev:103829.51 (4303.3%) stddev-sans-first:104088.11 12:28:55 INFO - PROCESS | 1660 | Values: 302.7 354.5 372.3 373.0 406.1 15112.3 15219.7 16171.8 17092.7 20527.6 19895.6 19919.0 20445.4 20655.4 20712.4 5955.7 6236.5 6241.3 6249.1 6250.7 4864.4 6188.2 6224.0 6249.7 6257.5 5979.5 6123.9 6205.6 6212.1 6213.5 5261.7 6111.0 6111.5 6165.4 6166.6 5084.7 5252.2 5323.4 5347.7 5348.7 25574.7 25671.6 25832.2 25897.8 25911.4 2235.1 2244.7 2343.3 2380.9 2444.7 15247.8 15633.1 15743.6 16046.4 16093.0 1848.0 1869.8 1919.8 1921.4 1932.8 98915.1 100686.5 103498.0 103858.0 105865.0 10517.9 10619.6 10930.5 11045.3 11330.3 11485.3 13585.9 13594.0 13594.6 13598.9 8590.4 8875.6 8896.6 8962.6 8979.8 8967.5 9000.3 9000.3 9167.9 9171.6 5529.8 6507.7 6588.9 6620.7 6718.1 1796.7 1832.9 1838.2 1876.2 1877.9 855.8 878.2 907.9 923.8 926.6 18377.9 20929.6 21982.0 22014.0 22026.2 901.7 942.7 949.2 962.7 983.7 9921.9 11398.3 11724.9 11754.6 11823.9 618484.0 623022.3 630944.0 632987.0 635115.0 110875.4 110950.0 113884.0 116274.4 120067.0 992.7 1002.9 1017.6 1018.4 1019.4 19176.0 19355.4 19745.6 19762.6 19807.0 49049.3 50880.2 50937.7 51547.0 53274.7 69741.7 70080.0 72674.6 72784.0 73770.6 6559.4 7781.8 7855.3 8007.2 8318.0 12863.5 12877.2 13002.4 13372.0 13415.7 11122.8 11127.0 11236.4 11473.3 11546.1 10802.6 10963.5 11027.2 11223.8 11427.9 11143.7 11189.5 11249.2 11420.3 11527.8 7821.0 7841.3 7870.0 8133.4 8258.6 11077.0 11226.6 11414.8 11472.8 11647.0 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5712.62 Median:4709.84 stddev:3258.08 (69.2%) stddev-sans-first:3250.73 12:28:55 INFO - PROCESS | 1660 | Values: 1350.1 1511.0 1513.0 1718.5 1886.6 7198.6 7914.9 8453.0 9024.5 9040.3 8949.1 9012.2 9032.3 9036.4 9044.3 2385.4 2420.2 2420.5 2421.0 2423.5 2381.3 2400.8 2426.4 2433.3 2439.7 2388.2 2413.0 2419.5 2421.1 2421.4 2368.9 2376.5 2380.3 2381.0 2416.0 2031.4 2356.8 2374.8 2382.5 2385.1 7956.8 8989.4 9010.6 9109.4 9132.8 5183.1 5437.1 5444.8 5486.4 5487.1 3619.4 3660.6 3686.7 3733.5 3741.5 1101.5 1102.3 1104.0 1118.6 1128.2 11796.1 11885.1 11904.2 11984.5 11997.2 4477.0 4531.2 4705.8 4713.9 4722.5 9266.3 9282.2 9288.9 9291.0 9298.1 5293.1 5294.4 5299.5 5302.3 5302.8 4167.7 4409.6 4554.2 4570.0 4935.6 3784.6 3826.6 3887.8 3895.6 3904.2 1138.1 1164.0 1167.5 1172.8 1177.6 825.7 895.2 905.7 910.9 923.9 5133.6 5366.9 5680.6 5947.5 6006.4 425.2 440.3 443.0 452.3 452.5 3400.5 3889.7 3901.6 3901.7 3999.9 10736.8 11024.4 11121.3 11135.9 11140.9 9433.0 10644.5 10916.7 11081.6 11096.3 8194.2 8305.3 8359.4 8429.8 8442.0 5465.5 5594.9 5679.7 5901.3 6002.9 10004.3 10063.8 10188.0 10291.6 10337.7 10326.0 10379.8 10397.1 10412.6 10527.9 7164.6 7178.5 7247.4 7251.8 7251.9 8342.6 8358.7 8454.2 8471.2 8492.8 7476.7 7600.9 7610.8 7659.5 7738.8 7445.7 7448.6 7480.9 7515.8 7529.2 7051.6 7072.1 7133.9 7157.0 7158.7 5005.0 5005.0 5013.8 5027.4 5058.1 4916.3 4979.1 5085.5 5143.0 5226.1 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4289.77 Median:4616.91 stddev:1289.12 (27.9%) stddev-sans-first:1256.58 12:28:55 INFO - PROCESS | 1660 | Values: 250.8 297.9 310.1 314.9 319.1 4231.7 4498.9 5330.4 5419.3 5419.9 4513.0 5216.6 5264.5 5289.9 5292.6 4042.8 4042.8 4076.3 4079.9 4119.7 3844.6 4053.6 4069.6 4084.2 4100.2 3522.7 4014.2 4020.0 4032.7 4086.3 4041.1 4051.6 4053.3 4055.7 4058.5 3556.5 3562.8 3571.2 3574.7 3582.8 4250.5 4653.4 4778.8 5142.7 5191.5 4330.0 4331.0 4607.5 4638.7 4678.4 4686.3 5199.5 5503.3 5586.3 5593.8 3197.8 3747.0 3868.6 3887.8 3920.3 5766.5 5778.0 5781.9 5799.4 5859.9 3535.8 3674.7 3989.9 3997.9 4011.2 3392.6 3899.9 4010.5 4040.4 4050.4 4508.6 4583.7 4591.6 4600.8 4687.9 4626.3 5591.5 5600.0 5649.4 5679.0 1242.3 1321.9 1325.5 1330.6 1351.9 772.4 917.8 927.4 929.9 934.6 4466.5 5132.2 5203.2 5309.4 5332.3 5601.3 5616.7 5641.0 5668.4 5684.4 4059.5 4532.4 4921.8 5083.6 5254.9 2359.5 2483.5 2485.7 2496.1 2520.0 4399.0 4824.7 4834.2 4864.3 4997.8 4213.6 4541.3 4759.5 4771.6 4867.9 4315.5 4347.8 4656.3 4871.4 4947.4 4335.9 4482.8 4535.9 4811.3 4837.8 3922.8 4056.8 4225.7 4466.7 4519.9 4100.4 4178.4 4857.6 4917.9 4965.5 3242.5 3400.8 3413.5 3422.3 3465.8 4705.6 4746.0 4752.7 4806.5 5432.7 4481.5 4819.3 5056.9 5436.3 5643.4 4499.3 5081.2 5539.7 5613.8 5617.2 4975.6 5060.9 5192.1 5394.9 5531.8 4669.9 5282.2 5675.6 5707.2 5716.3 5357.2 5526.7 5572.9 5593.8 5621.6 12:28:55 INFO - PROCESS | 1660 | 12:28:55 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25676.75 Median:3741.14 stddev:42043.96 (1123.8%) stddev-sans-first:42120.10 12:28:55 INFO - PROCESS | 1660 | Values: 704.4 797.6 799.8 806.2 810.3 14480.3 17562.7 17799.5 17802.9 17832.3 16595.2 16706.4 16767.5 16778.7 16779.7 661.5 820.0 848.7 853.1 853.8 672.9 685.7 819.6 842.5 849.8 888.3 891.0 891.4 893.4 894.6 888.9 889.5 889.8 891.6 892.2 506.7 519.4 524.2 525.3 654.4 12591.9 12629.3 15047.2 15296.6 15857.6 13952.4 14252.9 14313.2 14338.9 14512.9 11467.1 11770.2 11879.1 11967.9 12026.4 3809.1 3883.1 3896.2 3934.3 3978.2 115632.0 118669.0 119760.2 121216.0 122410.0 10361.6 10765.9 10802.0 10809.8 11155.0 21932.5 21993.6 22007.2 22198.0 22200.4 7774.7 7781.5 8018.6 8144.2 8163.9 4375.5 4410.3 4467.4 4614.2 4688.5 3599.9 3736.9 3740.6 3741.7 3745.2 651.1 653.8 662.6 669.2 673.5 555.8 578.2 591.8 641.2 650.6 7943.5 9008.5 9168.6 9590.6 9619.4 657.4 660.2 685.7 696.6 705.4 4572.8 4586.3 4594.5 4596.1 4626.3 176576.0 176591.1 177457.0 178446.0 181191.0 113564.0 115032.0 116596.4 129269.0 130910.0 89695.7 106120.3 109700.0 110356.0 111010.9 8512.6 9199.5 9928.4 9977.7 9979.0 57593.0 58268.8 58318.0 59083.7 59833.5 75072.0 90747.5 94287.0 96961.5 99120.0 12818.9 12948.3 13083.2 13149.8 13213.0 14039.2 14295.0 14559.5 14849.4 15729.5 13341.5 13747.5 14224.3 14750.8 14767.0 13593.2 14187.4 14680.0 14697.5 14839.3 13541.1 14215.4 14238.4 14266.3 14537.6 11155.6 11519.3 11751.6 11948.8 12281.8 9895.4 11524.5 11634.9 11698.2 11760.6 12:28:55 INFO - PROCESS | 1660 | -------- Summary: end -------- 12:28:55 INFO - PROCESS | 1660 | 12:28:56 INFO - TEST-INFO | 1660: exit 0 12:28:56 INFO - TEST-OK | dromaeo_css | took 1117592ms 12:28:56 INFO - TEST-START | kraken 12:28:56 INFO - operating with platform_type : mac_ 12:28:56 INFO - Initialising browser for kraken test... 12:28:56 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp9O_SaC/profile http://localhost:49266/getInfo.html) 12:28:58 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:28:58 INFO - PROCESS | 1665 | colorDepth:24 12:28:58 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 12:28:58 INFO - PROCESS | 1665 | __metrics 12:28:58 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:28:58 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:28:59 INFO - TEST-INFO | 1665: exit 0 12:28:59 INFO - Browser initialized. 12:28:59 INFO - Running cycle 1/1 for kraken test... 12:28:59 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp9O_SaC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:11 INFO - PROCESS | 1666 | RSS: Main: 219226112 12:29:11 INFO - PROCESS | 1666 | 12:29:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 12:29:14 INFO - PROCESS | 1666 | RSS: Main: 269373440 12:29:14 INFO - PROCESS | 1666 | 12:29:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 12:29:18 INFO - PROCESS | 1666 | RSS: Main: 281661440 12:29:18 INFO - PROCESS | 1666 | 12:29:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 12:29:22 INFO - PROCESS | 1666 | RSS: Main: 376963072 12:29:22 INFO - PROCESS | 1666 | 12:29:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 12:29:24 INFO - PROCESS | 1666 | RSS: Main: 280293376 12:29:24 INFO - PROCESS | 1666 | 12:29:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:29:27 INFO - PROCESS | 1666 | RSS: Main: 280854528 12:29:27 INFO - PROCESS | 1666 | 12:29:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 12:29:30 INFO - PROCESS | 1666 | RSS: Main: 319307776 12:29:30 INFO - PROCESS | 1666 | 12:29:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:34 INFO - PROCESS | 1666 | RSS: Main: 319991808 12:29:34 INFO - PROCESS | 1666 | 12:29:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 12:29:37 INFO - PROCESS | 1666 | RSS: Main: 318205952 12:29:37 INFO - PROCESS | 1666 | 12:29:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:39 INFO - PROCESS | 1666 | RSS: Main: 289861632 12:29:39 INFO - PROCESS | 1666 | 12:29:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:42 INFO - PROCESS | 1666 | RSS: Main: 296980480 12:29:42 INFO - PROCESS | 1666 | 12:29:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:45 INFO - PROCESS | 1666 | RSS: Main: 304369664 12:29:45 INFO - PROCESS | 1666 | 12:29:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:48 INFO - PROCESS | 1666 | RSS: Main: 306012160 12:29:48 INFO - PROCESS | 1666 | 12:29:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:52 INFO - PROCESS | 1666 | RSS: Main: 307507200 12:29:52 INFO - PROCESS | 1666 | 12:29:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 12:29:54 INFO - PROCESS | 1666 | RSS: Main: 351248384 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | __start_tp_report 12:29:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 12:29:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 12:29:54 INFO - PROCESS | 1666 | |i|pagename|runs| 12:29:54 INFO - PROCESS | 1666 | |0;ai-astar;114;113;111;112;112;114;111;112;113;117 12:29:54 INFO - PROCESS | 1666 | |1;audio-beat-detection;173;135;137;129;137;136;137;121;138;106 12:29:54 INFO - PROCESS | 1666 | |2;audio-dft;185;185;184;188;185;260;222;185;184;181 12:29:54 INFO - PROCESS | 1666 | |3;audio-fft;81;59;59;88;62;59;59;59;81;57 12:29:54 INFO - PROCESS | 1666 | |4;audio-oscillator;87;70;94;68;66;69;91;68;69;88 12:29:54 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;89;86;88;88;90;86;90;87;88;85 12:29:54 INFO - PROCESS | 1666 | |6;imaging-darkroom;98;101;146;161;161;98;98;97;99;98 12:29:54 INFO - PROCESS | 1666 | |7;imaging-desaturate;84;86;83;84;84;84;83;85;84;97 12:29:54 INFO - PROCESS | 1666 | |8;json-parse-financial;55;52;52;52;55;56;56;57;56;57 12:29:54 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;66;76;68;82;74;73;70;69;97;103 12:29:54 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;82;85;83;85;82;84;88;90;108 12:29:54 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;138;133;136;148;149;123;130;144;170;146 12:29:54 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;162;161;163;163;164;162;160;161;161;163 12:29:54 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;68;64;67;66;65;66;66;65;65;58 12:29:54 INFO - PROCESS | 1666 | __end_tp_report 12:29:54 INFO - PROCESS | 1666 | __start_cc_report 12:29:54 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2072 12:29:54 INFO - PROCESS | 1666 | __end_cc_report 12:29:54 INFO - PROCESS | 1666 | __startTimestamp1475004594198__endTimestamp 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | ------- Summary: start ------- 12:29:54 INFO - PROCESS | 1666 | Number of tests: 14 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.79 (1.6%) stddev-sans-first:1.86 12:29:54 INFO - PROCESS | 1666 | Values: 114.0 113.0 111.0 112.0 112.0 114.0 111.0 112.0 113.0 117.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:137.00 stddev:16.80 (12.3%) stddev-sans-first:10.76 12:29:54 INFO - PROCESS | 1666 | Values: 173.0 135.0 137.0 129.0 137.0 136.0 137.0 121.0 138.0 106.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:195.90 Median:185.00 stddev:25.46 (13.8%) stddev-sans-first:26.69 12:29:54 INFO - PROCESS | 1666 | Values: 185.0 185.0 184.0 188.0 185.0 260.0 222.0 185.0 184.0 181.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.50 stddev:11.90 (19.7%) stddev-sans-first:11.39 12:29:54 INFO - PROCESS | 1666 | Values: 81.0 59.0 59.0 88.0 62.0 59.0 59.0 59.0 81.0 57.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:11.38 (14.5%) stddev-sans-first:11.48 12:29:54 INFO - PROCESS | 1666 | Values: 87.0 70.0 94.0 68.0 66.0 69.0 91.0 68.0 69.0 88.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:1.70 (1.9%) stddev-sans-first:1.74 12:29:54 INFO - PROCESS | 1666 | Values: 89.0 86.0 88.0 88.0 90.0 86.0 90.0 87.0 88.0 85.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:115.70 Median:98.00 stddev:28.13 (28.7%) stddev-sans-first:29.09 12:29:54 INFO - PROCESS | 1666 | Values: 98.0 101.0 146.0 161.0 161.0 98.0 98.0 97.0 99.0 98.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:84.00 stddev:4.17 (5.0%) stddev-sans-first:4.39 12:29:54 INFO - PROCESS | 1666 | Values: 84.0 86.0 83.0 84.0 84.0 84.0 83.0 85.0 84.0 97.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.00 stddev:2.04 (3.6%) stddev-sans-first:2.17 12:29:54 INFO - PROCESS | 1666 | Values: 55.0 52.0 52.0 52.0 55.0 56.0 56.0 57.0 56.0 57.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:77.80 Median:73.50 stddev:12.63 (17.2%) stddev-sans-first:12.65 12:29:54 INFO - PROCESS | 1666 | Values: 66.0 76.0 68.0 82.0 74.0 73.0 70.0 69.0 97.0 103.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:84.50 stddev:7.82 (9.3%) stddev-sans-first:8.16 12:29:54 INFO - PROCESS | 1666 | Values: 83.0 82.0 85.0 83.0 85.0 82.0 84.0 88.0 90.0 108.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:145.00 stddev:13.02 (9.0%) stddev-sans-first:13.74 12:29:54 INFO - PROCESS | 1666 | Values: 138.0 133.0 136.0 148.0 149.0 123.0 130.0 144.0 170.0 146.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 12:29:54 INFO - PROCESS | 1666 | Values: 162.0 161.0 163.0 163.0 164.0 162.0 160.0 161.0 161.0 163.0 12:29:54 INFO - PROCESS | 1666 | 12:29:54 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:66.00 stddev:2.71 (4.1%) stddev-sans-first:2.65 12:29:54 INFO - PROCESS | 1666 | Values: 68.0 64.0 67.0 66.0 65.0 66.0 66.0 65.0 65.0 58.0 12:29:54 INFO - PROCESS | 1666 | -------- Summary: end -------- 12:29:54 INFO - PROCESS | 1666 | 12:29:55 INFO - TEST-INFO | 1666: exit 0 12:29:55 INFO - TEST-OK | kraken | took 59086ms 12:29:55 INFO - SUITE-END | took 1176s 12:29:55 INFO - Completed test suite (00:19:36) 12:29:55 INFO - javascript benchmark 12:29:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2826.3923256499875, 3297.4064668359697, 3317.601887773467, 3366.1079813849333, 3373.5445714828493, 5689.0, 5762.337331206902, 5764.971175144118, 5802.042662960612, 5805.361410244875, 5698.43015698431, 5769.798057068004, 5791.015527360349, 5802.071668533035, 5803.448672376117, 4324.502682191541, 5235.816746413876, 5255.211718242265, 5255.947440525603, 5329.413764485923, 5210.869728256805, 5217.7912883484805, 5361.249425080492, 5372.2210279509445, 5403.78384864605, 5254.500822421883, 5331.626786124973, 5332.706701131437, 5344.599155063386, 5350.0, 5304.071787437202, 5313.840584782462, 5325.334333208349, 5329.733513324319, 5335.093034184198, 5160.380754309469, 5258.710770907599, 5260.789568417297, 5265.921011184835, 5274.709890955995, 5744.540436765049, 5814.215080964058, 5833.504152147073, 5839.124131380285, 5845.532357411397, 6166.044263139221, 6173.166622505949, 6185.474234690057, 6230.283517395512, 6237.719302631393, 6261.906071408933, 6299.9370006299805, 6302.87394252117, 6313.87372252557, 6317.1156038154695, 5847.356790753014, 5858.150568167677, 5862.438695073795, 5868.853278668024, 5907.734151963172, 6177.598456100339, 6218.036204388327, 6265.4361107500545, 6305.590136641195, 6317.842053948596, 6125.78490979765, 6189.659568723763, 6197.504199664016, 6203.286622038433, 6211.3478084800445, 6314.684265786784, 6321.525885558602, 6328.841778955563, 6329.7468101275435, 6336.6831658416895, 6104.814386015445, 6148.1392605035335, 6175.135481032659, 6241.313455519889, 6284.811455656338, 6263.279722831841, 6322.304546499881, 6329.525285603599, 6330.0, 6334.968325158345, 4971.801127954914, 4974.626902982291, 4977.676451030671, 4980.377452818398, 4988.351514303117, 4335.0, 4384.780760961939, 4405.911881762347, 4432.756198409054, 4463.486699029589, 5906.232189815382, 5909.438603332676, 5912.556558258148, 5925.73334199962, 5926.0, 6242.15730876335, 6293.1504246927, 6299.338569450233, 6329.177206963157, 6331.810045698637, 5664.943350566442, 5717.714114294268, 5725.799597014167, 5746.626469279484, 5862.70686465675, 5381.0583147948955, 5441.809536666197, 5459.754311055933, 5485.780568777284, 5496.6701997880255, 5294.179402192666, 6349.238091429058, 6359.332270111757, 6371.23545174582, 6372.2034745655865, 6117.3576774439825, 6291.182146320949, 6312.242530896322, 6328.493720502441, 6332.493400528039, 6215.254169499508, 6249.1563638908165, 6262.436380725574, 6320.652364119834, 6326.557141000086, 6221.253449586078, 6263.342349053284, 6269.874602507833, 6274.435300822948, 6275.0, 6239.0, 6240.313565507699, 6284.842878928063, 6290.779822706183, 6298.653574053471, 5298.337707786527, 6024.156618073385, 6093.817185484265, 6101.0, 6177.536684748752, 6083.574149809471, 6161.353057929032, 6163.506919446523, 6179.073139029181, 6210.472109870711, 6056.121862330026, 6089.0, 6098.725557349841, 6104.755809767559, 6105.17580126695, 5971.313298970674, 6036.486898613492, 6044.697765111815, 6204.410580994799, 6204.441600255998, 4904.362432883702, 5284.365876094893, 5613.438656134354, 6051.788187413419, 6066.545009124245], "value": 5725.147295264427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.3771429142134, 496.1763472635426, 518.7224834713428, 532.0343576408818, 549.5658429840427, 29747.0, 35662.64337356626, 41511.0, 42916.99999999996, 44812.0, 36906.630933690656, 43970.34044489327, 44374.11251774963, 44404.777976110076, 44632.77683611585, 9735.31852770308, 9935.652252171176, 9950.353227040256, 9954.352967057155, 9991.450470224136, 8874.290056795473, 9068.183863452288, 9079.046700096495, 9222.308326875478, 9734.318597698164, 9157.084291570856, 12155.817662735066, 12405.689857753538, 12485.313307768069, 12650.493980240779, 12142.332171730552, 12152.966997805108, 12179.208351457128, 12443.875561244407, 12478.688032799162, 8834.911650883538, 9073.0, 12228.510859565607, 12329.136960412774, 12331.198472099284, 40500.98747531306, 41057.38413923793, 41069.38395924064, 43270.78364608188, 43335.78332108351, 3367.6295607483157, 3500.9649903500895, 3559.252556963015, 3741.3265612189794, 4031.717779755418, 31655.683443165504, 31761.682383176103, 31997.680023199704, 32048.839755801306, 32275.677243227503, 3027.8334691591954, 3118.5322201669705, 3169.5721077654453, 3178.7933784304178, 3179.586653735, 517571.0, 518724.0, 521435.39282303344, 521612.0, 522144.0, 45195.93236608721, 55571.44428555744, 64416.35583644197, 66067.33932660708, 67751.0, 67505.0, 68564.0, 68732.3126768736, 68777.31222687809, 68941.0, 17050.57373565646, 17208.65582688339, 17226.0, 17229.22468488921, 17231.741523877154, 13101.951843852468, 13148.40832162555, 13181.143225690299, 13203.801942970864, 13320.0, 16800.495985120466, 17184.570385740208, 17248.741268880978, 19532.70700939487, 19572.0, 6939.965300173467, 7601.0, 7661.233876612406, 7812.828075788677, 7989.7203597873795, 847.4025811802665, 935.5789894547481, 965.1940629574244, 992.7270000749852, 1023.9488025598839, 29504.81980720747, 30335.848320758254, 31003.0, 31169.0, 32247.67752322447, 1018.8879223285433, 1047.8323468245044, 1083.9864726480766, 1112.9109671226283, 1159.2726837012958, 14843.960922735521, 15543.0, 15696.979696319702, 15739.282111425227, 15876.444324448588, 624530.0, 629735.0, 638371.0, 639973.0, 641342.0, 50842.74578627083, 51786.96426071457, 51816.48183518192, 54529.45470545244, 54537.181942270894, 1272.7263638317806, 1422.9857701423061, 1423.38794318442, 1445.985540144627, 1446.985530144685, 28882.711172888, 29969.850150749106, 32619.34761304808, 33729.0, 34115.31769364649, 57679.0, 58451.0, 58533.4146658545, 58573.5356616088, 58599.70700146472, 615337.0, 620964.0, 625062.0, 626755.0, 647797.0, 36890.44664330091, 43968.78015609901, 44157.77921110374, 44721.10557788761, 44796.32805507985, 42188.94527636834, 45186.77406612946, 48816.511834881196, 49091.26363104485, 49189.754051229516, 39453.605463944994, 39771.0, 40173.0, 40457.59542404538, 41626.0, 40037.39943900902, 40126.3256471946, 40577.59422405738, 41860.79069604632, 41932.37101443542, 38344.0, 39002.0, 39764.2047159061, 39867.2026559473, 40060.399094014196, 32209.838950805097, 32957.0, 33123.0, 35260.0, 35926.101847454025, 26059.08793192229, 26067.364087806694, 26110.477790443703, 26139.0, 26376.340591485365], "value": 21001.08519014979, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.74266873157814, 354.519625906896, 372.26663472958273, 372.9813509324535, 406.0964354311657, 15112.319945602447, 15219.695606087886, 16171.757423638655, 17092.692486514316, 20527.589448211027, 19895.602087958232, 19919.0, 20445.386638400872, 20655.380338589828, 20712.378628641127, 5955.731992060357, 6236.532260080489, 6241.251049873998, 6249.125122482856, 6250.718717657694, 4864.416270047599, 6188.226471691039, 6224.035274532454, 6249.687515624223, 6257.468115210213, 5979.491743201811, 6123.908141377883, 6205.627662340252, 6212.068189771525, 6213.533984951124, 5261.657992230531, 6111.02223644217, 6111.480524155408, 6165.445109940082, 6166.568340216187, 5084.720340381277, 5252.1596544552685, 5323.387810401815, 5347.732613369316, 5348.652337598043, 25574.744252557422, 25671.614925776128, 25832.225033249033, 25897.79868711162, 25911.352216194748, 2235.083615717548, 2244.708187935558, 2343.308723926446, 2380.9285721428387, 2444.669969554105, 15247.847521524754, 15633.062016278946, 15743.606409839846, 16046.438374656831, 16093.034417934961, 1847.9630407391912, 1869.7662792150982, 1919.779225389084, 1921.4139687395339, 1932.845372370207, 98915.10916246439, 100686.49656751669, 103498.0, 103858.0, 105865.0, 10517.947410263052, 10619.575216991389, 10930.453477326102, 11045.33727976324, 11330.263532870336, 11485.310881347146, 13585.932070339783, 13594.0, 13594.592162235149, 13598.864011359958, 8590.398672093019, 8875.644974200959, 8896.644134234559, 8962.596683149273, 8979.820403592023, 8967.542336617362, 9000.279977601776, 9000.324975626854, 9167.862482062774, 9171.63313467454, 5529.778808847601, 6507.739690412331, 6588.86822263552, 6620.735170593122, 6718.0930574372815, 1796.7215081662364, 1832.9266829326943, 1838.1911958738112, 1876.2307453943818, 1877.9248830046918, 855.8074433252593, 878.1701292278735, 907.8865141857268, 923.8429466990627, 926.6200857648466, 18377.887903957573, 20929.58140837205, 21982.0, 22014.00936957841, 22026.229081982376, 901.6610333654518, 942.6794889737386, 949.1979277510493, 962.6871266838166, 983.680303901235, 9921.851172232422, 11398.259113157617, 11724.94137529324, 11754.647360579196, 11823.940880295544, 618484.0, 623022.3164293692, 630944.0, 632987.0, 635115.0, 110875.44562277298, 110950.0, 113884.0, 116274.41862790631, 120067.0, 992.7220378294089, 1002.8997100289913, 1017.6285655735603, 1018.3584341864578, 1019.4189312092036, 19176.0, 19355.4193374199, 19745.60508789845, 19762.604747904676, 19807.0, 49049.26426103683, 50880.23679644882, 50937.74531127469, 51547.0, 53274.73362633162, 69741.65129174321, 70080.0, 72674.63662681653, 72784.0, 73770.63114684392, 6559.376859198369, 7781.844363112819, 7855.33229675484, 8007.1592482788465, 8318.0, 12863.549775757803, 12877.227366358049, 13002.414891330101, 13372.0, 13415.731685366043, 11122.813147320807, 11127.0, 11236.381998990135, 11473.254238474472, 11546.13403994687, 10802.567897284021, 10963.451827408438, 11027.22809403334, 11223.775524489627, 11427.942860285646, 11143.72140696489, 11189.496472658913, 11249.212555121063, 11420.257683250562, 11527.827082593936, 7820.960895195488, 7841.333486653698, 7869.960650196713, 8133.389995750461, 8258.587070646323, 11077.0, 11226.607068752555, 11414.828777568177, 11472.82790758156, 11647.0], "value": 9675.688598785551, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.1021820489375, 1511.0253886243377, 1512.992435037825, 1718.4758648612176, 1886.6226754649065, 7198.604076775782, 7914.920850791497, 8452.957735211323, 9024.503652299121, 9040.321975851804, 8949.149830766082, 9012.188902998729, 9032.322575806807, 9036.41263317884, 9044.27645788337, 2385.403649087728, 2420.177139772477, 2420.5279970405777, 2421.019487107724, 2423.491066875958, 2381.297517232412, 2400.8319417640773, 2426.417659761662, 2433.2943446400523, 2439.6828412306377, 2388.152205966874, 2413.0, 2419.5160967806423, 2421.116292553223, 2421.382547450398, 2368.8815559222144, 2376.5128148729555, 2380.2621187431864, 2381.0356805493802, 2415.9637605435933, 2031.4413536277493, 2356.8232382571377, 2374.7743964323363, 2382.5234953009467, 2385.0936644075314, 7956.766701161271, 8989.37074404792, 9010.639574417015, 9109.407888487227, 9132.771680707969, 5183.118869792144, 5437.102878025121, 5444.754986025639, 5486.3690675572025, 5487.122060470306, 3619.4389869569995, 3660.560732712065, 3686.668199862025, 3733.533308336458, 3741.5323084614424, 1101.5043230546287, 1102.2780079048237, 1103.9724006899812, 1118.6364431559775, 1128.1651577832345, 11796.056315494654, 11885.108616853771, 11904.226225295328, 11984.52061917531, 11997.160198786089, 4476.977615111904, 4531.184386810406, 4705.788239529229, 4713.882152946135, 4722.480527142012, 9266.258699304039, 9282.164605185566, 9288.90711092894, 9291.024442433447, 9298.116678915492, 5293.073712100367, 5294.41761406245, 5299.4700529946695, 5302.310699609026, 5302.840914772563, 4167.687423443193, 4409.647228221735, 4554.180247555471, 4570.0, 4935.629827762932, 3784.5836957934607, 3826.598207188205, 3887.8056097195026, 3895.590962948906, 3904.1606054698377, 1138.1407037686495, 1163.9804938431814, 1167.4746364136172, 1172.8299396587447, 1177.617274385828, 825.6532256452305, 895.1630225738955, 905.6513242401722, 910.9225715814098, 923.9353245272766, 5133.589312855037, 5366.946330536723, 5680.573956953162, 5947.49446297061, 6006.369331220247, 425.19213494360963, 440.3043191757016, 443.04081663198815, 452.3350674508533, 452.49094768385567, 3400.506926495644, 3889.7277190596387, 3901.551321597996, 3901.668358189586, 3999.920001599952, 10736.838947415796, 11024.44877756125, 11121.332720036824, 11135.944320278346, 11140.888591114148, 9432.95283523578, 10644.467776611138, 10916.727081823017, 11081.612143575097, 11096.33421994683, 8194.22154895284, 8305.294050005818, 8359.414840961195, 8429.777682236165, 8441.986961564651, 5465.453454654662, 5594.888102238014, 5679.6876171810945, 5901.3213480450295, 6002.879942401215, 10004.349717268355, 10063.849042264519, 10188.0, 10291.588336466457, 10337.74155646115, 10326.01902819231, 10379.792404151724, 10397.064264216257, 10412.583496660352, 10527.94736026315, 7164.641767911479, 7178.497505174588, 7247.420206383582, 7251.782446526613, 7251.927480725336, 8342.582870856555, 8358.665653373797, 8454.196851299117, 8471.237588617054, 8492.830143397221, 7476.738314159196, 7600.885986710315, 7610.8097297568, 7659.502132361602, 7738.806529836799, 7445.739399121221, 7448.627568621656, 7480.925190748023, 7515.812104697427, 7529.171791103084, 7051.576905385693, 7072.08062951813, 7133.928660713534, 7157.033800436874, 7158.749443769443, 5005.049040682259, 5005.049040682259, 5013.824516142064, 5027.371578552681, 5058.08954388199, 4916.262560615936, 4979.103761322996, 5085.466026067357, 5143.0, 5226.059309324358], "value": 4496.455894878814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [250.80437258938028, 297.8763813017598, 310.0945239899493, 314.9354382351618, 319.05082379919725, 4231.746095234281, 4498.932516012263, 5330.36035675719, 5419.349678038631, 5419.945800541994, 4512.984578469843, 5216.634835561512, 5264.473552644734, 5289.947100528993, 5292.576593872491, 4042.7574345539215, 4042.777647229394, 4076.2866498362814, 4079.8572049978256, 4119.732217405874, 3844.5770965193806, 4053.6351728344443, 4069.633732964033, 4084.1831633673237, 4100.220958017967, 3522.7005704515145, 4014.237294913957, 4019.9799001004953, 4032.6975476839207, 4086.264472394968, 4041.1006826791363, 4051.6353528182312, 4053.310937140693, 4055.7363771354917, 4058.533268674111, 3556.5020897074432, 3562.806459835958, 3571.196480791827, 3574.6782789549065, 3582.7671201371827, 4250.4899412070445, 4653.371794807692, 4778.757523043999, 5142.665726727751, 5191.506806853343, 4329.9567004329865, 4330.956690433119, 4607.516210797851, 4638.744869032202, 4678.391809064834, 4686.250199967989, 5199.506046925536, 5503.257060296849, 5586.301712285965, 5593.8321850344555, 3197.8081315120935, 3746.981265093684, 3868.5551161616495, 3887.844486220548, 3920.313945059632, 5766.452187042224, 5777.971110144423, 5781.942180578182, 5799.449052340021, 5859.912101318484, 3535.805530695785, 3674.669279764834, 3989.860354887565, 3997.920561448451, 4011.1949622669918, 3392.5759280089987, 3899.902502437462, 4010.498687664042, 4040.373742069984, 4050.3924411338535, 4508.639308855284, 4583.716559363384, 4591.612361571963, 4600.7929643166135, 4687.906241875144, 4626.306054091913, 5591.46881046308, 5599.9920014396985, 5649.378568357477, 5679.0345641240265, 1242.3353505874495, 1321.9206847588982, 1325.4565628092437, 1330.60081975407, 1351.8783309502192, 772.3782355204114, 917.7980844214262, 927.4342650982895, 929.8558723397749, 934.6495064350869, 4466.486354069259, 5132.204508301219, 5203.245529398216, 5309.398394786527, 5332.346972438479, 5601.29983752031, 5616.719164041781, 5640.971795140998, 5668.433156684298, 5684.37471878093, 4059.5331536873637, 4532.4334458192725, 4921.803127874845, 5083.644144909895, 5254.947450525522, 2359.4927090675587, 2483.503299340139, 2485.6644353012475, 2496.078019924648, 2519.9920031987353, 4398.978005109954, 4824.662273640882, 4834.154023045953, 4864.343313652683, 4997.800087996439, 4213.578642135823, 4541.296099104644, 4759.547842954914, 4771.618270538349, 4867.92905560776, 4315.4605674290715, 4347.782610869507, 4656.32483289921, 4871.415430148405, 4947.441555909877, 4335.913281734284, 4482.803426321145, 4535.863924082283, 4811.326414302071, 4837.799365681976, 3922.843086276517, 4056.776877271778, 4225.668914291989, 4466.731996080245, 4519.909601808011, 4100.405441210948, 4178.435911151955, 4857.611391088633, 4917.926231106465, 4965.503449655005, 3242.4812030075077, 3400.812955287483, 3413.4879768034994, 3422.2813209225346, 3465.757396982187, 4705.576498115186, 4746.003339298786, 4752.667313288037, 4806.49531799156, 5432.728363581884, 4481.462224533077, 4819.2530157825595, 5056.873578160576, 5436.3476382834315, 5643.391633384465, 4499.257622492252, 5081.221572449613, 5539.723013849372, 5613.831585052455, 5617.213590097308, 4975.577075948585, 5060.8987820242655, 5192.091384007859, 5394.892102158014, 5531.778728850801, 4669.906601867876, 5282.234076059027, 5675.631083979528, 5707.20099186106, 5716.256886604715, 5357.1696387060065, 5526.668399896019, 5572.86067848307, 5593.804216852391, 5621.622702437929], "value": 3887.0094587780936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.4047779626216, 797.6211299632679, 799.7520768561747, 806.2461598405488, 810.3031393002019, 14480.275986200688, 17562.73655895161, 17799.46601601954, 17802.910985445054, 17832.28670853166, 16595.170241487907, 16706.415275465362, 16767.496975090737, 16778.74831877523, 16779.664406711858, 661.4576047640936, 819.991800081999, 848.7114381110421, 853.117023880284, 853.8420392227458, 672.899065140228, 685.6503183376489, 819.5779173725537, 842.5155535567073, 849.8427790858711, 888.3026823943206, 891.0243283604443, 891.3760367742574, 893.4282059481936, 894.6466145872377, 888.8622263549096, 889.4618755652866, 889.8353804546115, 891.5987805487524, 892.2237653241689, 506.68585477004126, 519.353405010764, 524.2424696313828, 525.2829887203977, 654.4469922915176, 12591.937040314831, 12629.305388203646, 15047.247637618075, 15296.617584560363, 15857.60355991098, 13952.441902323895, 14252.857471425257, 14313.212773297464, 14338.856611433857, 14512.927435362755, 11467.139964502612, 11770.176087673866, 11879.109066820023, 11967.880321196764, 12026.39868006605, 3809.142942837867, 3883.0680636647285, 3896.1818018215927, 3934.3311637021775, 3978.204359128157, 115632.0, 118669.0, 119760.20359694524, 121216.0, 122410.0, 10361.63734269312, 10765.946170269099, 10802.027817496462, 10809.83785243222, 11154.996050355507, 21932.45168870759, 21993.560128797333, 22007.2297469591, 22198.0, 22200.444988875406, 7774.727884524128, 7781.455298129076, 8018.5990700464745, 8144.226298501633, 8163.877541836877, 4375.47494300686, 4410.25025745624, 4467.396901418332, 4614.238650622677, 4688.484266730657, 3599.874004409833, 3736.925261494755, 3740.60723624021, 3741.6819570336825, 3745.213505163946, 651.0657206908102, 653.761377097356, 662.642173226462, 669.2170160911745, 673.515069150211, 555.8193587084214, 578.1616655849035, 591.795830438498, 641.153677146172, 650.5673726971511, 7943.4836735612, 9008.549572521348, 9168.607625111183, 9590.616375344907, 9619.422834629804, 657.3992328679585, 660.2341284110408, 685.7336502858002, 696.6377483708443, 705.4497491956282, 4572.81708731647, 4586.266197408466, 4594.540545945379, 4596.149712303235, 4626.329182268552, 176576.0, 176591.11704441396, 177457.0, 178446.0, 181191.0, 113564.0, 115032.0, 116596.41701791437, 129269.0, 130910.03634945484, 89695.65456518157, 106120.34699132583, 109700.0, 110356.0, 111010.88989110006, 8512.616932238188, 9199.494027828534, 9928.404295742279, 9977.700668979942, 9978.950105249427, 57593.0, 58268.83462330815, 58318.0, 59083.70458147682, 59833.50416239454, 75072.0, 90747.54626226827, 94287.0, 96961.51519242358, 99120.0, 12818.935905320413, 12948.28784416866, 13083.215007099605, 13149.802752958522, 13213.0, 14039.157650541, 14295.0, 14559.490417835324, 14849.40602375893, 15729.528114156594, 13341.466341346237, 13747.518836840663, 14224.288785560888, 14750.778738319148, 14767.04014239071, 13593.184408935496, 14187.432502699776, 14680.0, 14697.485588004369, 14839.258037098318, 13541.1198272112, 14215.431382744575, 14238.430462781373, 14266.286685665467, 14537.636559086108, 11155.609553665583, 11519.30884146954, 11751.60317238366, 11948.761024779282, 12281.815772763595, 9895.356801807859, 11524.481398337262, 11634.94182529082, 11698.239614425034, 11760.58837940668], "value": 7904.76073538712, "unit": "score"}], "name": "dromaeo_css", "value": 7373.766339990615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 111.0, 112.0, 112.0, 114.0, 111.0, 112.0, 113.0, 117.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 135.0, 137.0, 129.0, 137.0, 136.0, 137.0, 121.0, 138.0, 106.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 188.0, 185.0, 260.0, 222.0, 185.0, 184.0, 181.0], "value": 195.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 62.0, 59.0, 59.0, 59.0, 81.0, 57.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 68.0, 66.0, 69.0, 91.0, 68.0, 69.0, 88.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 88.0, 90.0, 86.0, 90.0, 87.0, 88.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 101.0, 146.0, 161.0, 161.0, 98.0, 98.0, 97.0, 99.0, 98.0], "value": 115.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 84.0, 84.0, 84.0, 83.0, 85.0, 84.0, 97.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 52.0, 55.0, 56.0, 56.0, 57.0, 56.0, 57.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 68.0, 82.0, 74.0, 73.0, 70.0, 69.0, 97.0, 103.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 83.0, 85.0, 82.0, 84.0, 88.0, 90.0, 108.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 136.0, 148.0, 149.0, 123.0, 130.0, 144.0, 170.0, 146.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 164.0, 162.0, 160.0, 161.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 67.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 58.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1464.2, "alertThreshold": 2.0}]} 12:29:55 INFO - Return code: 0 12:29:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:29:55 INFO - # TBPL SUCCESS # 12:29:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:29:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:29:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:29:55 INFO - 2016-09-27 12:29:55.533 screenresolution[1670:10427] starting screenresolution argv=screenresolution get 12:29:55 INFO - 2016-09-27 12:29:55.536 screenresolution[1670:10427] Display 0: 1600x1200x32@60 12:29:55 INFO - 2016-09-27 12:29:55.542 screenresolution[1671:10430] starting screenresolution argv=screenresolution list 12:29:55 INFO - Available Modes on Display 0 12:29:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:29:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:29:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:29:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:29:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:29:55 INFO - Intel Iris: 12:29:55 INFO - Chipset Model: Intel Iris 12:29:55 INFO - Type: GPU 12:29:55 INFO - Bus: Built-In 12:29:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:29:55 INFO - Vendor: Intel (0x8086) 12:29:55 INFO - Device ID: 0x0a2e 12:29:55 INFO - Revision ID: 0x0009 12:29:55 INFO - Displays: 12:29:55 INFO - Display: 12:29:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:29:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:29:55 INFO - Display Serial Number: 1600x1200 60 12:29:55 INFO - Main Display: Yes 12:29:55 INFO - Mirror: Off 12:29:55 INFO - Online: Yes 12:29:55 INFO - Rotation: Supported 12:29:55 INFO - Return code: 0 12:29:55 INFO - Running post-action listener: _resource_record_post_action 12:29:55 INFO - [mozharness: 2016-09-27 19:29:55.778909Z] Finished run-tests step (success) 12:29:55 INFO - Running post-run listener: _resource_record_post_run 12:29:55 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 33115136; Write bytes: 662461952; Read time: 307; Write time: 1973 12:29:55 INFO - TinderboxPrint: CPU usage
53.4% 12:29:55 INFO - TinderboxPrint: I/O read bytes / time
33,115,136 / 307 12:29:55 INFO - TinderboxPrint: I/O write bytes / time
662,461,952 / 1,973 12:29:55 INFO - TinderboxPrint: CPU idle
2,254.2 (46.6%) 12:29:55 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 12:29:55 INFO - TinderboxPrint: CPU user
1,618.7 (33.4%) 12:29:55 INFO - TinderboxPrint: Swap in / out
391,995,392 / 0 12:29:55 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 353378816; Write bytes: 348391424; Read time: 27285; Write time: 671 12:29:55 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 32164864; Write bytes: 296089088; Read time: 292; Write time: 1247 12:29:56 INFO - Running post-run listener: _upload_blobber_files 12:29:56 INFO - Blob upload gear active. 12:29:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:29:56 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 12:29:56 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'] 12:29:56 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 12:29:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:57 INFO - (blobuploader) - INFO - Done attempting. 12:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:58 INFO - (blobuploader) - INFO - Done attempting. 12:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:01 INFO - (blobuploader) - INFO - Done attempting. 12:30:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:30:01 INFO - Return code: 0 12:30:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:30:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:30:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c048607ee16de8d780123b58ef3c46948271fab419cfa2f93f8fec5c1fc7e0d5a9b0301c1364bb8d80558812cfdeb343342d7602ecb24efdef08c74a85e5afaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ba49874dc98f3c5bf3ffffde81e565349b30719c2bfc3e4fabbb8029b7729e4ed6a3e9bdaec04ef110469468c76a67a98eead470f8af897ff09b7b46a4fb7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c0ce43f1e262d6ee0df0f8d632402b3611f0e58a8620741870add3aed88adcb9687931a659e521c7080af24cb5884c8e2e687a2c358f5192693268ea4dd234"} 12:30:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:30:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:30:01 INFO - Contents: 12:30:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c048607ee16de8d780123b58ef3c46948271fab419cfa2f93f8fec5c1fc7e0d5a9b0301c1364bb8d80558812cfdeb343342d7602ecb24efdef08c74a85e5afaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ba49874dc98f3c5bf3ffffde81e565349b30719c2bfc3e4fabbb8029b7729e4ed6a3e9bdaec04ef110469468c76a67a98eead470f8af897ff09b7b46a4fb7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c0ce43f1e262d6ee0df0f8d632402b3611f0e58a8620741870add3aed88adcb9687931a659e521c7080af24cb5884c8e2e687a2c358f5192693268ea4dd234"} 12:30:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:30:01 INFO - Copying logs to upload dir... 12:30:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:30:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.457110 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-27 12:30:01.472639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 12:30:01.477325) ========= 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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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/c048607ee16de8d780123b58ef3c46948271fab419cfa2f93f8fec5c1fc7e0d5a9b0301c1364bb8d80558812cfdeb343342d7602ecb24efdef08c74a85e5afaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ba49874dc98f3c5bf3ffffde81e565349b30719c2bfc3e4fabbb8029b7729e4ed6a3e9bdaec04ef110469468c76a67a98eead470f8af897ff09b7b46a4fb7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c0ce43f1e262d6ee0df0f8d632402b3611f0e58a8620741870add3aed88adcb9687931a659e521c7080af24cb5884c8e2e687a2c358f5192693268ea4dd234"} build_url:https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010731 build_url: 'https://queue.taskcluster.net/v1/task/M-JiOamuT2G6tRrEv8YwrQ/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/c048607ee16de8d780123b58ef3c46948271fab419cfa2f93f8fec5c1fc7e0d5a9b0301c1364bb8d80558812cfdeb343342d7602ecb24efdef08c74a85e5afaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ba49874dc98f3c5bf3ffffde81e565349b30719c2bfc3e4fabbb8029b7729e4ed6a3e9bdaec04ef110469468c76a67a98eead470f8af897ff09b7b46a4fb7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f6c0ce43f1e262d6ee0df0f8d632402b3611f0e58a8620741870add3aed88adcb9687931a659e521c7080af24cb5884c8e2e687a2c358f5192693268ea4dd234"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 12:30:01.512807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:30:01.513158) ========= 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.CZTpLFGsYR/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.R9pzcGkMmf/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.004996 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:30:01.561599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 12:30:01.564977) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 12:30:01.565347) ========= ========= Total master_lag: 0.19 =========