builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0195 starttime: 1479405433.53 results: success (0) buildid: 20161117073328 builduid: 3252d071457d4ca59e43e1ba427b0e8a revision: bcafa3ea224b818b4ffb165da4fa7a51f3d80280 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.531189) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.532290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.532948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.560668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.561403) ========= 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.qFdqefeqpT/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.78suuS5RHX/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 09:57:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.0M=0s 2016-11-17 09:57:13 (28.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119932 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.711108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.711444) ========= 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.qFdqefeqpT/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.78suuS5RHX/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.029203 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:13.761395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 09:57:13.761766) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bcafa3ea224b818b4ffb165da4fa7a51f3d80280 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bcafa3ea224b818b4ffb165da4fa7a51f3d80280 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qFdqefeqpT/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.78suuS5RHX/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 09:57:13,855 truncating revision to first 12 chars 2016-11-17 09:57:13,856 Setting DEBUG logging. 2016-11-17 09:57:13,856 attempt 1/10 2016-11-17 09:57:13,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bcafa3ea224b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 09:57:15,387 unpacking tar archive at: mozilla-beta-bcafa3ea224b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.816939 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 09:57:15.604676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:15.605342) ========= script_repo_revision: bcafa3ea224b818b4ffb165da4fa7a51f3d80280 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:15.605823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:15.606217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 09:57:15.626357) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-17 09:57:15.627027) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qFdqefeqpT/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.78suuS5RHX/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:15 INFO - MultiFileLogger online at 20161117 09:57:15 in /builds/slave/test 09:57:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:57:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:15 INFO - {'append_to_log': False, 09:57:15 INFO - 'base_work_dir': '/builds/slave/test', 09:57:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:57:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:15 INFO - 'branch': 'Mozilla-Beta', 09:57:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:15 INFO - 'config_files': ('talos/mac_config.py',), 09:57:15 INFO - 'default_actions': ('clobber', 09:57:15 INFO - 'read-buildbot-config', 09:57:15 INFO - 'download-and-extract', 09:57:15 INFO - 'populate-webroot', 09:57:15 INFO - 'create-virtualenv', 09:57:15 INFO - 'install', 09:57:15 INFO - 'run-tests'), 09:57:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:15 INFO - 'download_minidump_stackwalk': True, 09:57:15 INFO - 'download_symbols': 'ondemand', 09:57:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:15 INFO - 'installer_path': 'installer.exe', 09:57:15 INFO - 'log_level': 'info', 09:57:15 INFO - 'log_name': 'talos', 09:57:15 INFO - 'log_to_console': True, 09:57:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:57:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:57:15 INFO - 'opt_config_files': (), 09:57:15 INFO - 'pip_index': False, 09:57:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:15 INFO - 'cmd': ('bash', 09:57:15 INFO - '-c', 09:57:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:15 INFO - 'enabled': True, 09:57:15 INFO - 'halt_on_failure': False, 09:57:15 INFO - 'name': 'check_screen_resolution'},), 09:57:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:15 INFO - 'cmd': ('bash', 09:57:15 INFO - '-c', 09:57:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:15 INFO - 'enabled': True, 09:57:15 INFO - 'halt_on_failure': False, 09:57:15 INFO - 'name': 'check_screen_resolution'},), 09:57:15 INFO - 'run_cmd_checks_enabled': True, 09:57:15 INFO - 'sps_profile': False, 09:57:15 INFO - 'sps_profile_interval': 0, 09:57:15 INFO - 'suite': 'dromaeojs', 09:57:15 INFO - 'system_bits': '32', 09:57:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:15 INFO - 'title': 't-yosemite-r7-0195', 09:57:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:15 INFO - 'use_talos_json': True, 09:57:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:15 INFO - 'work_dir': 'build'} 09:57:15 INFO - [mozharness: 2016-11-17 17:57:15.829406Z] Running clobber step. 09:57:15 INFO - Running pre-action listener: _resource_record_pre_action 09:57:15 INFO - Running main action method: clobber 09:57:15 INFO - rmtree: /builds/slave/test/build 09:57:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:18 INFO - Running post-action listener: _resource_record_post_action 09:57:18 INFO - [mozharness: 2016-11-17 17:57:18.179468Z] Finished clobber step (success) 09:57:18 INFO - [mozharness: 2016-11-17 17:57:18.179604Z] Running read-buildbot-config step. 09:57:18 INFO - Running pre-action listener: _resource_record_pre_action 09:57:18 INFO - Running main action method: read_buildbot_config 09:57:18 INFO - Using buildbot properties: 09:57:18 INFO - { 09:57:18 INFO - "project": "", 09:57:18 INFO - "product": "firefox", 09:57:18 INFO - "script_repo_revision": "production", 09:57:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:57:18 INFO - "repository": "", 09:57:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:57:18 INFO - "buildid": "20161117073328", 09:57:18 INFO - "pgo_build": "False", 09:57:18 INFO - "basedir": "/builds/slave/test", 09:57:18 INFO - "buildnumber": 65, 09:57:18 INFO - "slavename": "t-yosemite-r7-0195", 09:57:18 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:57:18 INFO - "platform": "yosemite_r7", 09:57:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:57:18 INFO - "branch": "mozilla-beta", 09:57:18 INFO - "repo_path": "releases/mozilla-beta", 09:57:18 INFO - "revision": "bcafa3ea224b818b4ffb165da4fa7a51f3d80280", 09:57:18 INFO - "stage_platform": "macosx64", 09:57:18 INFO - "builduid": "3252d071457d4ca59e43e1ba427b0e8a", 09:57:18 INFO - "slavebuilddir": "test" 09:57:18 INFO - } 09:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:57:18 INFO - Running post-action listener: _resource_record_post_action 09:57:18 INFO - [mozharness: 2016-11-17 17:57:18.182998Z] Finished read-buildbot-config step (success) 09:57:18 INFO - [mozharness: 2016-11-17 17:57:18.183110Z] Running download-and-extract step. 09:57:18 INFO - Running pre-action listener: _resource_record_pre_action 09:57:18 INFO - Running main action method: download_and_extract 09:57:18 INFO - mkdir: /builds/slave/test/build/tests 09:57: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')]} 09:57:18 INFO - trying https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:57:18 INFO - Downloading https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 09:57:19 INFO - Downloaded 1165 bytes. 09:57:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:57:19 INFO - Using the following test package requirements: 09:57:19 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:57:19 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:57:19 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:57:19 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:57:19 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:57:19 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:57:19 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:57:19 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:57:19 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:57:19 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:57:19 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:57:19 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:57:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:57:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:57:19 INFO - Fetch https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:57:20 INFO - Expected file size: 16231339 09:57:27 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:57:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:57:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:57:27 INFO - Fetch https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:57:27 INFO - Expected file size: 16231339 09:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:57:35 INFO - Expected file size: 14414089 09:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:35 INFO - trying https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:57:35 INFO - Downloading https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 09:57:38 INFO - Downloaded 86016574 bytes. 09:57:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:57:38 INFO - mkdir: /builds/slave/test/properties 09:57:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:38 INFO - Contents: 09:57:38 INFO - build_url:https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:57:38 INFO - Running post-action listener: _resource_record_post_action 09:57:38 INFO - Running post-action listener: set_extra_try_arguments 09:57:38 INFO - [mozharness: 2016-11-17 17:57:38.931564Z] Finished download-and-extract step (success) 09:57:38 INFO - [mozharness: 2016-11-17 17:57:38.931700Z] Running populate-webroot step. 09:57:38 INFO - Running pre-action listener: _resource_record_pre_action 09:57:38 INFO - Running main action method: populate_webroot 09:57:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:38 INFO - '--tppagecycles', 09:57:38 INFO - '7'], 09:57:38 INFO - 'tests': ['tsvgm']}}, 09:57:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:57:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:57:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['damp', 'tps']}, 09:57:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'tests': ['damp', 'tps']}, 09:57:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['dromaeo_dom']}, 09:57:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['basic_compositor_video']}, 09:57:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:57:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['a11yr', 09:57:38 INFO - 'ts_paint', 09:57:38 INFO - 'tpaint', 09:57:38 INFO - 'sessionrestore', 09:57:38 INFO - 'sessionrestore_no_auto_restore', 09:57:38 INFO - 'tabpaint']}, 09:57:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:57:38 INFO - 'ts_paint', 09:57:38 INFO - 'tpaint', 09:57:38 INFO - 'sessionrestore', 09:57:38 INFO - 'sessionrestore_no_auto_restore', 09:57:38 INFO - 'tabpaint']}, 09:57:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:57:38 INFO - 'ts_paint', 09:57:38 INFO - 'tpaint', 09:57:38 INFO - 'sessionrestore', 09:57:38 INFO - 'sessionrestore_no_auto_restore', 09:57:38 INFO - 'tabpaint']}, 09:57:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:57:38 INFO - 'ts_paint', 09:57:38 INFO - 'tpaint', 09:57:38 INFO - 'sessionrestore', 09:57:38 INFO - 'sessionrestore_no_auto_restore', 09:57:38 INFO - 'tabpaint']}, 09:57:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['a11yr', 09:57:38 INFO - 'ts_paint', 09:57:38 INFO - 'tpaint', 09:57:38 INFO - 'sessionrestore', 09:57:38 INFO - 'sessionrestore_no_auto_restore', 09:57:38 INFO - 'tabpaint']}, 09:57:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['a11yr', 09:57:38 INFO - 'ts_paint', 09:57:38 INFO - 'tpaint', 09:57:38 INFO - 'sessionrestore', 09:57:38 INFO - 'sessionrestore_no_auto_restore', 09:57:38 INFO - 'tabpaint']}, 09:57:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['tsvgx', 09:57:38 INFO - 'tsvgr_opacity', 09:57:38 INFO - 'tart', 09:57:38 INFO - 'tscrollx', 09:57:38 INFO - 'cart']}, 09:57:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:57:38 INFO - 'tsvgr_opacity', 09:57:38 INFO - 'tart', 09:57:38 INFO - 'tscrollx', 09:57:38 INFO - 'cart']}, 09:57:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'talos_options': ['--disable-e10s'], 09:57:38 INFO - 'tests': ['tp5o']}, 09:57:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'tests': ['tp5o']}, 09:57:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'talos_options': ['--disable-e10s', 09:57:38 INFO - '--xperf_path', 09:57:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:38 INFO - 'tests': ['tp5n']}, 09:57:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:38 INFO - 'talos_options': ['--xperf_path', 09:57:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:38 INFO - 'tests': ['tp5n']}}, 09:57:38 INFO - 'talos.zip': {'path': '', 09:57:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:38 INFO - Running post-action listener: _resource_record_post_action 09:57:38 INFO - [mozharness: 2016-11-17 17:57:38.950605Z] Finished populate-webroot step (success) 09:57:38 INFO - [mozharness: 2016-11-17 17:57:38.950709Z] Running create-virtualenv step. 09:57:38 INFO - Running pre-action listener: _resource_record_pre_action 09:57:38 INFO - Running main action method: create_virtualenv 09:57:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:38 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 09:57:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:39 INFO - Using real prefix '/tools/python27' 09:57:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:42 INFO - Installing pip.................done. 09:57:42 INFO - Return code: 0 09:57:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:42 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:42 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 09:57:42 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 09:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:42 INFO - 'HOME': '/Users/cltbld', 09:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:42 INFO - 'LOGNAME': 'cltbld', 09:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:42 INFO - 'MOZ_NO_REMOTE': '1', 09:57:42 INFO - 'NO_EM_RESTART': '1', 09:57:42 INFO - 'PAGER': '/bin/cat', 09:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:42 INFO - 'PWD': '/builds/slave/test', 09:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:42 INFO - 'SHELL': '/bin/bash', 09:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:42 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:42 INFO - 'USER': 'cltbld', 09:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:42 INFO - 'XPC_FLAGS': '0x0', 09:57:42 INFO - 'XPC_SERVICE_NAME': '0', 09:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:43 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 09:57:43 INFO - Cleaning up... 09:57:43 INFO - Return code: 0 09:57:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:57:43 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')]} 09:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:43 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')]} 09:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:43 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:43 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 09:57:43 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 09:57:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:43 INFO - 'HOME': '/Users/cltbld', 09:57:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:43 INFO - 'LOGNAME': 'cltbld', 09:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:43 INFO - 'MOZ_NO_REMOTE': '1', 09:57:43 INFO - 'NO_EM_RESTART': '1', 09:57:43 INFO - 'PAGER': '/bin/cat', 09:57:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:43 INFO - 'PWD': '/builds/slave/test', 09:57:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:43 INFO - 'SHELL': '/bin/bash', 09:57:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:43 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:43 INFO - 'USER': 'cltbld', 09:57:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:43 INFO - 'XPC_FLAGS': '0x0', 09:57:43 INFO - 'XPC_SERVICE_NAME': '0', 09:57:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:43 INFO - Downloading/unpacking psutil>=3.1.1 09:57:43 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 09:57:43 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 09:57:43 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 09:57:43 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 09:57:43 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 09:57:43 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 09:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:46 INFO - Installing collected packages: psutil 09:57:46 INFO - Running setup.py install for psutil 09:57:46 INFO - building 'psutil._psutil_osx' extension 09:57:46 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 INFO - building 'psutil._psutil_posix' extension 09:57:47 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 09:57:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:57:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:57:47 INFO - ^ 09:57:47 INFO - 1 warning generated. 09:57:47 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 09:57:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:47 INFO - Successfully installed psutil 09:57:47 INFO - Cleaning up... 09:57:47 INFO - Return code: 0 09:57:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:47 INFO - 'HOME': '/Users/cltbld', 09:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:47 INFO - 'LOGNAME': 'cltbld', 09:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:47 INFO - 'MOZ_NO_REMOTE': '1', 09:57:47 INFO - 'NO_EM_RESTART': '1', 09:57:47 INFO - 'PAGER': '/bin/cat', 09:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:47 INFO - 'PWD': '/builds/slave/test', 09:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:47 INFO - 'SHELL': '/bin/bash', 09:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:47 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:47 INFO - 'USER': 'cltbld', 09:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:47 INFO - 'XPC_FLAGS': '0x0', 09:57:47 INFO - 'XPC_SERVICE_NAME': '0', 09:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:47 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 09:57:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:57:50 INFO - Installing collected packages: mozsystemmonitor 09:57:50 INFO - Running setup.py install for mozsystemmonitor 09:57:50 INFO - Successfully installed mozsystemmonitor 09:57:50 INFO - Cleaning up... 09:57:50 INFO - Return code: 0 09:57:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:50 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:50 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 09:57:50 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 09:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:50 INFO - 'HOME': '/Users/cltbld', 09:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:50 INFO - 'LOGNAME': 'cltbld', 09:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:50 INFO - 'MOZ_NO_REMOTE': '1', 09:57:50 INFO - 'NO_EM_RESTART': '1', 09:57:50 INFO - 'PAGER': '/bin/cat', 09:57:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:50 INFO - 'PWD': '/builds/slave/test', 09:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:50 INFO - 'SHELL': '/bin/bash', 09:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:50 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:50 INFO - 'USER': 'cltbld', 09:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:50 INFO - 'XPC_FLAGS': '0x0', 09:57:50 INFO - 'XPC_SERVICE_NAME': '0', 09:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:57:51 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 09:57:51 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 09:57:51 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 09:57:51 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 09:57:51 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 09:57:51 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 09:57:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:57:53 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 09:57:53 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 09:57:53 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 09:57:53 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 09:57:53 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 09:57:53 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 09:57:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:54 INFO - warning: no files found matching '*.txt' 09:57:54 INFO - no previously-included directories found matching 'build' 09:57:54 INFO - no previously-included directories found matching 'dist' 09:57:54 INFO - no previously-included directories found matching '.git*' 09:57:54 INFO - Installing collected packages: jsonschema, functools32 09:57:54 INFO - Running setup.py install for functools32 09:57:54 INFO - warning: no files found matching '*.txt' 09:57:54 INFO - no previously-included directories found matching 'build' 09:57:54 INFO - no previously-included directories found matching 'dist' 09:57:54 INFO - no previously-included directories found matching '.git*' 09:57:54 INFO - Successfully installed jsonschema functools32 09:57:54 INFO - Cleaning up... 09:57:54 INFO - Return code: 0 09:57:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:57:54 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')]} 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 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')]} 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:54 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 09:57:54 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 09:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:54 INFO - 'HOME': '/Users/cltbld', 09:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:54 INFO - 'LOGNAME': 'cltbld', 09:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:54 INFO - 'MOZ_NO_REMOTE': '1', 09:57:54 INFO - 'NO_EM_RESTART': '1', 09:57:54 INFO - 'PAGER': '/bin/cat', 09:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:54 INFO - 'PWD': '/builds/slave/test', 09:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:54 INFO - 'SHELL': '/bin/bash', 09:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:54 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:54 INFO - 'USER': 'cltbld', 09:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:54 INFO - 'XPC_FLAGS': '0x0', 09:57:54 INFO - 'XPC_SERVICE_NAME': '0', 09:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:57:54 INFO - Cleaning up... 09:57:54 INFO - Return code: 0 09:57:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:54 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')]} 09:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 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')]} 09:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:54 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:54 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 09:57:54 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 09:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:54 INFO - 'HOME': '/Users/cltbld', 09:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:54 INFO - 'LOGNAME': 'cltbld', 09:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:54 INFO - 'MOZ_NO_REMOTE': '1', 09:57:54 INFO - 'NO_EM_RESTART': '1', 09:57:54 INFO - 'PAGER': '/bin/cat', 09:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:54 INFO - 'PWD': '/builds/slave/test', 09:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:54 INFO - 'SHELL': '/bin/bash', 09:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:54 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:54 INFO - 'USER': 'cltbld', 09:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:54 INFO - 'XPC_FLAGS': '0x0', 09:57:54 INFO - 'XPC_SERVICE_NAME': '0', 09:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:54 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 09:57:54 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 09:57:54 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 09:57:54 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 09:57:54 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 09:57:54 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 09:57:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 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 09:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:58 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 09:57:58 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 09:57:58 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 09:57:58 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 09:57:58 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 09:57:58 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 09:57:58 INFO - Downloading docopt-0.6.1.tar.gz 09:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:58 INFO - Running setup.py install for blobuploader 09:57:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:58 INFO - Running setup.py install for requests 09:57:59 INFO - Running setup.py install for docopt 09:57:59 INFO - Successfully installed blobuploader requests docopt 09:57:59 INFO - Cleaning up... 09:57:59 INFO - Return code: 0 09:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:59 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')]} 09:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:59 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')]} 09:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:59 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:57:59 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 09:57:59 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 09:57:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:57:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:59 INFO - 'HOME': '/Users/cltbld', 09:57:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:59 INFO - 'LOGNAME': 'cltbld', 09:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:59 INFO - 'MOZ_NO_REMOTE': '1', 09:57:59 INFO - 'NO_EM_RESTART': '1', 09:57:59 INFO - 'PAGER': '/bin/cat', 09:57:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:59 INFO - 'PWD': '/builds/slave/test', 09:57:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:59 INFO - 'SHELL': '/bin/bash', 09:57:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:57:59 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:57:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:59 INFO - 'USER': 'cltbld', 09:57:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:59 INFO - 'XPC_FLAGS': '0x0', 09:57:59 INFO - 'XPC_SERVICE_NAME': '0', 09:57:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-CgTQdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-KrxefP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-qcAh6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-xr9XcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-vUVaKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-xkhXtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-_AWEol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-dPY76l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-I5xJWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Qpbnbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-dL8fni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-FJiMxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:01 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-TP1L_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:01 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-ZcX1X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:01 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-aQKeVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:01 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-GV_xtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:01 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-XUkXSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:01 INFO - Running setup.py install for manifestparser 09:58:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:01 INFO - Running setup.py install for mozcrash 09:58:01 INFO - Running setup.py install for mozdebug 09:58:01 INFO - Running setup.py install for mozdevice 09:58:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozfile 09:58:02 INFO - Running setup.py install for mozhttpd 09:58:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozinfo 09:58:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozInstall 09:58:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:02 INFO - Running setup.py install for mozleak 09:58:02 INFO - Running setup.py install for mozlog 09:58:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Running setup.py install for moznetwork 09:58:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Running setup.py install for mozprocess 09:58:03 INFO - Running setup.py install for mozprofile 09:58:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Running setup.py install for mozrunner 09:58:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:03 INFO - Running setup.py install for mozscreenshot 09:58:03 INFO - Running setup.py install for moztest 09:58:04 INFO - Running setup.py install for mozversion 09:58:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:04 INFO - Cleaning up... 09:58:04 INFO - Return code: 0 09:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:04 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')]} 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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')]} 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:04 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:58:04 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 09:58:04 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 09:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:04 INFO - 'HOME': '/Users/cltbld', 09:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:04 INFO - 'LOGNAME': 'cltbld', 09:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:04 INFO - 'MOZ_NO_REMOTE': '1', 09:58:04 INFO - 'NO_EM_RESTART': '1', 09:58:04 INFO - 'PAGER': '/bin/cat', 09:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:04 INFO - 'PWD': '/builds/slave/test', 09:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:04 INFO - 'SHELL': '/bin/bash', 09:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:58:04 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:04 INFO - 'USER': 'cltbld', 09:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:04 INFO - 'XPC_FLAGS': '0x0', 09:58:04 INFO - 'XPC_SERVICE_NAME': '0', 09:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:04 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-JNguwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:04 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)) 09:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:04 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-0HkTco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-wfnKQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-DwS2Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-VOIWuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-GIJpnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-gdj1ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-IaEv7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-lCo8IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-sFmwBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:05 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)) 09:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:05 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-L_HYOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:06 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-qvmDIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:06 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-4_ekFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:06 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-XmyUVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:06 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Ao4cRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:06 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-zoLjh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:06 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)) 09:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:06 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-pbRlpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:06 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)) 09:58:06 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)) 09:58:06 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)) 09:58:06 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)) 09:58:06 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)) 09:58:06 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)) 09:58:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:09 INFO - Downloading blessings-1.6.tar.gz 09:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:09 INFO - Installing collected packages: blessings 09:58:09 INFO - Running setup.py install for blessings 09:58:09 INFO - Successfully installed blessings 09:58:09 INFO - Cleaning up... 09:58:09 INFO - Return code: 0 09:58:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:10 INFO - Reading from file tmpfile_stdout 09:58:10 INFO - Current package versions: 09:58:10 INFO - blessings == 1.6 09:58:10 INFO - blobuploader == 1.2.4 09:58:10 INFO - docopt == 0.6.1 09:58:10 INFO - functools32 == 3.2.3-2 09:58:10 INFO - jsonschema == 2.5.1 09:58:10 INFO - manifestparser == 1.1 09:58:10 INFO - mozInstall == 1.12 09:58:10 INFO - mozcrash == 0.17 09:58:10 INFO - mozdebug == 0.1 09:58:10 INFO - mozdevice == 0.48 09:58:10 INFO - mozfile == 1.2 09:58:10 INFO - mozhttpd == 0.7 09:58:10 INFO - mozinfo == 0.9 09:58:10 INFO - mozleak == 0.1 09:58:10 INFO - mozlog == 3.4 09:58:10 INFO - moznetwork == 0.27 09:58:10 INFO - mozprocess == 0.23 09:58:10 INFO - mozprofile == 0.28 09:58:10 INFO - mozrunner == 6.12 09:58:10 INFO - mozscreenshot == 0.1 09:58:10 INFO - mozsystemmonitor == 0.3 09:58:10 INFO - moztest == 0.7 09:58:10 INFO - mozversion == 1.4 09:58:10 INFO - psutil == 3.1.1 09:58:10 INFO - requests == 1.2.3 09:58:10 INFO - wsgiref == 0.1.2 09:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 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 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:58:10 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 09:58:10 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 09:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:10 INFO - 'HOME': '/Users/cltbld', 09:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:10 INFO - 'LOGNAME': 'cltbld', 09:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:10 INFO - 'MOZ_NO_REMOTE': '1', 09:58:10 INFO - 'NO_EM_RESTART': '1', 09:58:10 INFO - 'PAGER': '/bin/cat', 09:58:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:10 INFO - 'PWD': '/builds/slave/test', 09:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:10 INFO - 'SHELL': '/bin/bash', 09:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:58:10 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:10 INFO - 'USER': 'cltbld', 09:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:10 INFO - 'XPC_FLAGS': '0x0', 09:58:10 INFO - 'XPC_SERVICE_NAME': '0', 09:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 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)) 09:58:10 INFO - Cleaning up... 09:58:10 INFO - Return code: 0 09:58:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c46490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bbc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac4ad71a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, '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.qFdqefeqpT/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.78suuS5RHX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 09:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:10 INFO - 'HOME': '/Users/cltbld', 09:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:10 INFO - 'LOGNAME': 'cltbld', 09:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:10 INFO - 'MOZ_NO_REMOTE': '1', 09:58:10 INFO - 'NO_EM_RESTART': '1', 09:58:10 INFO - 'PAGER': '/bin/cat', 09:58:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:10 INFO - 'PWD': '/builds/slave/test', 09:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:10 INFO - 'SHELL': '/bin/bash', 09:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:58:10 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:10 INFO - 'USER': 'cltbld', 09:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:10 INFO - 'XPC_FLAGS': '0x0', 09:58:10 INFO - 'XPC_SERVICE_NAME': '0', 09:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:10 INFO - Cleaning up... 09:58:10 INFO - Return code: 0 09:58:10 INFO - Running post-action listener: _resource_record_post_action 09:58:10 INFO - Running post-action listener: _start_resource_monitoring 09:58:10 INFO - Starting resource monitoring. 09:58:10 INFO - [mozharness: 2016-11-17 17:58:10.752700Z] Finished create-virtualenv step (success) 09:58:10 INFO - [mozharness: 2016-11-17 17:58:10.753737Z] Running install step. 09:58:10 INFO - Running pre-action listener: _resource_record_pre_action 09:58:10 INFO - Running main action method: install 09:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:11 INFO - Reading from file tmpfile_stdout 09:58:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:11 INFO - Reading from file tmpfile_stdout 09:58:11 INFO - Output received: 09:58:11 INFO - Usage: mozinstall [options] installer 09:58:11 INFO - Options: 09:58:11 INFO - -h, --help show this help message and exit 09:58:11 INFO - -d DEST, --destination=DEST 09:58:11 INFO - Directory to install application into. [default: 09:58:11 INFO - "/builds/slave/test"] 09:58:11 INFO - --app=APP Application being installed. [default: firefox] 09:58:11 INFO - mkdir: /builds/slave/test/build/application 09:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:58:33 INFO - Reading from file tmpfile_stdout 09:58:33 INFO - Output received: 09:58:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:58:33 INFO - Running post-action listener: _resource_record_post_action 09:58:33 INFO - [mozharness: 2016-11-17 17:58:33.245728Z] Finished install step (success) 09:58:33 INFO - [mozharness: 2016-11-17 17:58:33.245856Z] Running run-tests step. 09:58:33 INFO - Running pre-action listener: _resource_record_pre_action 09:58:33 INFO - Running main action method: run_tests 09:58:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:33 INFO - 2016-11-17 09:58:33.260 screenresolution[1624:7375] starting screenresolution argv=screenresolution get 09:58:33 INFO - 2016-11-17 09:58:33.263 screenresolution[1624:7375] Display 0: 1600x1200x32@60 09:58:33 INFO - 2016-11-17 09:58:33.269 screenresolution[1625:7377] starting screenresolution argv=screenresolution list 09:58:33 INFO - Available Modes on Display 0 09:58:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:33 INFO - Intel Iris: 09:58:33 INFO - Chipset Model: Intel Iris 09:58:33 INFO - Type: GPU 09:58:33 INFO - Bus: Built-In 09:58:33 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:33 INFO - Vendor: Intel (0x8086) 09:58:33 INFO - Device ID: 0x0a2e 09:58:33 INFO - Revision ID: 0x0009 09:58:33 INFO - Displays: 09:58:33 INFO - Display: 09:58:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:33 INFO - Display Serial Number: 1600x1200 60 09:58:33 INFO - Main Display: Yes 09:58:33 INFO - Mirror: Off 09:58:33 INFO - Online: Yes 09:58:33 INFO - Rotation: Supported 09:58:33 INFO - Return code: 0 09:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:33 INFO - Python 2.7.3 09:58:33 INFO - Return code: 0 09:58:33 INFO - grabbing minidump binary from tooltool 09:58: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')]} 09:58:33 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 0x107a5ad30>, '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 0x1078c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107a52b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:33 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 09:58:33 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 09:58:33 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 09:58:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:33 INFO - Return code: 0 09:58:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--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 09:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0195 --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 09:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qFdqefeqpT/Render', 09:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:33 INFO - 'HOME': '/Users/cltbld', 09:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:33 INFO - 'LOGNAME': 'cltbld', 09:58:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:33 INFO - 'MOZ_NO_REMOTE': '1', 09:58:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:33 INFO - 'NO_EM_RESTART': '1', 09:58:33 INFO - 'PAGER': '/bin/cat', 09:58:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:33 INFO - 'PWD': '/builds/slave/test', 09:58:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:33 INFO - 'SHELL': '/bin/bash', 09:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.78suuS5RHX/Listeners', 09:58:33 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 09:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:33 INFO - 'USER': 'cltbld', 09:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:33 INFO - 'XPC_FLAGS': '0x0', 09:58:33 INFO - 'XPC_SERVICE_NAME': '0', 09:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--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 09:58:33 INFO - mozversion application_buildid: 20161117073328 09:58:33 INFO - mozversion application_changeset: bcafa3ea224b818b4ffb165da4fa7a51f3d80280 09:58:33 INFO - mozversion application_display_name: Firefox 09:58:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:33 INFO - mozversion application_name: Firefox 09:58:33 INFO - mozversion application_remotingname: firefox 09:58:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:33 INFO - mozversion application_vendor: Mozilla 09:58:33 INFO - mozversion application_version: 51.0 09:58:33 INFO - mozversion platform_buildid: 20161117073328 09:58:33 INFO - mozversion platform_changeset: bcafa3ea224b818b4ffb165da4fa7a51f3d80280 09:58:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:58:33 INFO - mozversion platform_version: 51.0 09:58:33 INFO - using testdate: 1479405513 09:58:33 INFO - actual date: 1479405513 09:58:33 INFO - starting webserver on 'localhost:49246' 09:58:33 INFO - SUITE-START | Running 2 tests 09:58:33 INFO - TEST-START | dromaeo_css 09:58:33 INFO - operating with platform_type : mac_ 09:58:33 INFO - Initialising browser for dromaeo_css test... 09:58:33 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpm8P0BV/profile http://localhost:49246/getInfo.html) 09:58:36 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 09:58:36 INFO - PROCESS | 1635 | colorDepth:24 09:58:36 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 09:58:36 INFO - PROCESS | 1635 | __metrics 09:58:36 INFO - PROCESS | 1635 | 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" 09:58:36 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:36 INFO - TEST-INFO | 1635: exit 0 09:58:36 INFO - Browser initialized. 09:58:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:36 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpm8P0BV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:48 INFO - PROCESS | 1638 | RSS: Main: 168390656 09:58:48 INFO - PROCESS | 1638 | 09:59:40 INFO - PROCESS | 1638 | 1479405580635 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] 10:01:51 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 10:01:52 INFO - PROCESS | 1638 | RSS: Main: 316063744 10:01:52 INFO - PROCESS | 1638 | 10:04:55 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 10:04:55 INFO - PROCESS | 1638 | RSS: Main: 300978176 10:04:55 INFO - PROCESS | 1638 | 10:07:58 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 10:07:58 INFO - PROCESS | 1638 | RSS: Main: 276230144 10:07:58 INFO - PROCESS | 1638 | 10:11:00 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 10:11:01 INFO - PROCESS | 1638 | RSS: Main: 275935232 10:11:01 INFO - PROCESS | 1638 | 10:14:04 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 10:14:05 INFO - PROCESS | 1638 | RSS: Main: 258338816 10:14:05 INFO - PROCESS | 1638 | 10:17:07 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 10:17:08 INFO - PROCESS | 1638 | RSS: Main: 350302208 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | __start_tp_report 10:17:08 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:17:08 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:17:08 INFO - PROCESS | 1638 | |i|pagename|runs| 10:17:08 INFO - PROCESS | 1638 | |0;dojo.html;2745.7254274572556;3471.4792781082842;3472.2534655049158;3516.1561225305904;3549.041758725144;5839.9124013139835;5880.2355693759855;5910.438508341711;5945.9891818390815;5988.221531200948;4968.180250258703;5096.031753966744;5912.290525136989;5948.702564871761;5962.344142144371;5303.098473259555;5322.654027488211;5331.813386531472;5372.946270537283;5379.35447746271;5245.344331958505;5246.9212961805415;5278.577713782888;5398.8920221595545;5429.4570542945585;5315.0698627740185;5319.20211968206;5320.17537281722;5322.4411436799155;5350;5318.30861987943;5323.840284791462;5403.2705584745945;5403.594730395236;5412.83761487156;5187.714675692835;5258.605604579634;5348.625596208267;5356.250124982505;5373.489518495776;5717.571182161355;5754.568407369464;5764.452377024176;5824.359320474744;5841.153032810261;6211.9068213976825;6270.341614130496;6288.151099601541;6293.653849038301;6327.81016569499;6239.407256310643;6271.749130034793;6281.685915704196;6291.276503202099;6326.93673063268;5774.855628609276;5776.277965254343;5815.156802263648;5832.300123985149;5834.824955251349;6313.40022697843;6331.651759153198;6338.524610654127;6352.237731472253;6360.52296077796;6238.376162383816;6243.594166379171;6246.656433896089;6247.718852651642;6249.812505624838;6182.938170618326;6193.287771906198;6256.280527739368;6314;6342.334054924167;5627.5779316551425;5976.013957697019;6218.751249949952;6283.183186185766;6347.904781428282;6226.719797609118;6294.370562943669;6304.401081897213;6312.652804095727;6321.65230912295;4964.304997300381;5038.1183292924325;5045.495450454999;5065.670731402447;5065.974670126626;4506.616937560344;4515.1195516873895;4561.384213131251;4589.403377560896;4594.333821595917;4859.3682821233015;5958.106284057426;5984.311804142492;6073.08903664445;6121.755129794758;6233.750649974041;6241.407066328691;6289.968550157311;6303;6305.527085468608;5852.882942341214;6022.698865056817;6030.6080104793045;6047.546434017467;6067.969660151759;5486.835394938158;5489.972550137224;5529.0324193266015;5531.612787104864;5536.4186760390385;6475.838104047437;6479.611223326427;6488.2538508072175;6497.122888410004;6505.381988711065;6244.812655620339;6262.749490020348;6265.248170219421;6265.96867015662;6267.874642507216;6277.74889004453;6306.747730090929;6342.904856427065;6345.682715864281;6386.904196436964;6287.937120628918;6296.937030629635;6310.5898116622275;6321.589096708699;6322.936770632235;6246.406591373812;6259.467945224525;6263.248410190807;6271.843203919939;6275.435210831047;5297.152455607084;6134.9079763804475;6145.508359331332;6239.188905442264;6284.905726414016;4988.077205716954;6245.6252624842655;6263;6277.278113016879;6309.05364195356;6130.785422510191;6137.048757442603;6144.170536977451;6147.262328520606;6153.4154255345675;6123.7244324006415;6157.4458298753325;6233.96883015582;6293.181886354744;6298.11826344303;6071.878562428815;6082.787102451393;6143.72353244114;6169.321374648695;6177.752889884354 10:17:08 INFO - PROCESS | 1638 | |1;ext.html;488.93643826302576;495.68276303166004;541.7643325153557;543.945605439456;548.8984537860493;31998;41931.371029434544;43564.346534802;43617.56382436175;45524.089518209614;45346.31980520295;45700.77149614247;45740.85647858797;45752.71236438173;45998.01012934157;9990;10180.898191018106;10181;10197.337173083726;10244.590216391336;9382;9614.855777163348;9620.326577139567;9712.417254964725;9717.46553939533;12303.815442768366;12575.622731318075;12583.245005299666;12740.93629531851;12742.55401060963;12534.435950382254;12629.179103358298;12636;12637.304948227844;12644;12400.945919596756;12486.188397754117;12488.50045998168;12490.50037998479;12496.687582810502;42333;42558.787206063775;42746.1450770986;42795.144097118195;42890.78554607207;3457.360388328167;3478.7912725236315;3602.279544091166;3619.855205791765;3788.22341420011;32361.676383236336;32536;32629.51055734166;32630.673693263238;32718.509222361685;3299.983500082484;3353.4299169141304;3409.6419875913166;3426.691597756214;3502.562179727534;534801;537189;537288;537473;538000;35168.47247291293;62535;62988.370116299164;63102;63192.684036580446;35772;37099.62900370962;37173.81413092971;37185.44221836675;37201.81399092987;15686;15838.52484425469;15840.287187076608;15848.366065357488;15861;13208.867911320764;13310.800337994939;13322.267275299757;13327.666808329675;13328.06703530763;6578.243501997236;7553;7692.307692307719;8108.108108108104;8173.632186551619;3400.795952242873;3413.4367829307885;3430;3430.1767575781632;3454.6199918008997;991.0782971836262;1022.6829682798208;1023.559869256227;1067.8558394616628;1115.765689205276;30715.8464207682;30757.84621076925;30963.45182740854;31593.36813263768;31625.683743162735;1086.2450596835124;1113.6881673131536;1134.6271012075317;1144.336284954741;1191.4102519253024;16214.594635134215;16377.918110409371;16399.262033208535;16492.670146597;16532.46915119033;694848.5257573781;714256;714872;717253;717607.2358914621;61348;61791;61801;61817;61867.07199392013;1489.47868246113;1490.1431676786108;1496.2369191712305;1530.3037118111233;1535.1403214200084;28981;30363.544546832258;30409.847950760104;30704.925327613426;30907.227319317197;54200;55056.724716376164;55081;55119.173212401045;55131.72434137804;670058;677095;677421;679809.6009519921;680136;36725;44551.554484456035;44927;45101.77449112733;47045.52954470548;47806.28290575575;48807;49256.507434925195;49402.50597493979;49897.75051124721;40235.79882100688;40522.79738601406;41400.37899431451;41593.37609935914;42301.78849105735;40730;41062.17875642411;41126.383104254055;41199.97000075022;42305;37471.43792843164;37532.437013445364;37652.87041388763;37671.81164094162;40594;31518.842405787826;32773.67226327706;35937;36652.63347366599;36895.631043689216;27022.26557445574;27242.727572724812;27338.179854604394;27351.58972615452;27574 10:17:08 INFO - PROCESS | 1638 | |2;jquery.html;340.4773672412847;364.6717953841542;377.65821931152317;381.1975790960029;411.23099803367705;17744.82255177448;19607.313744018964;21151.682724759143;21233.787662123374;22048.228312009083;11905.464254108565;12126.272423654587;12334.136610437274;12334.568290109848;12356.443960021797;5309.539876533955;5629.155626656014;5633.211350410946;5634.802781902634;5640.858978525549;4095.262852686515;4141.9585804142025;4165.66674666026;4207.579242075783;5539.861503462405;5599.692016939067;6001.429864162919;6146.354632763562;6235.376462353751;6264.686765661721;6120.357362476942;6868.313168683117;6928.064711263965;6932.272111428278;6946.687399067054;5259.132243179871;5545.611807173499;6125.540584456184;6132.7546898124465;6147.538934579924;13665.795013074812;13722.519711810039;13845.446182152802;13908.721825563433;13925.373358198905;2127.8297736181066;2371.679823223877;2380.678608387863;2432.2095319021387;2569.4218800769863;10158.187345012455;10242.590296388136;10254;10631.627893023708;10730;1694.93220271189;1988.0556735550642;1994.5113447205383;2004.5589970206531;2024.5242368043498;117072;118955;123024;123955.38022309922;128898.3555082228;9322.25421966241;11196.66410007701;11597.014253788522;11643.359615221245;11722.648320550397;14490.203038832755;14527.346269417902;14528.346224419927;14542.909281803906;14552.927235363755;8167.224113709188;8394.958025209835;8498.872516912252;8529.786755331043;8611.50266422743;6894.413974812197;8204.343652507785;8275.131111233233;8445.662173513114;8546.871796923051;4378.634705062572;4448.621867141329;4480.820767169342;4510.368548403226;4525.954740452619;1813.9002354870609;1834.908254587292;1849.704047352417;1905.1993569452882;1956.178405069874;900.1223806788329;929.8233335666337;931.897491275959;959.2230293462318;1007.5768177365524;20977.580448390945;21713.348599542038;22013.889930550245;22111.336659899905;22193.89030548466;946.8958414574391;965.8502932045544;985.8422652375729;1013.381837079381;1031.8039572481205;10910.963458471433;11569.710757230969;11635.894590013935;11658.300501969909;11673.824892626617;613408;633604;650616;666137;666588;59385.406145938854;77970.2202977963;136281.3185934084;137325.62674373327;138476.30761846126;875.9386842921061;963.7471287326588;994.6319861651091;1018.8675472188717;1020.5407566595062;13774.725329257823;18220.544486387415;18540.907295463436;19612.705809412586;20172.193112275345;57061.144082837964;57270;58324.125138122115;59704;60440;79887;80775.59612201901;81904.77142842743;84763.57618212116;86116.13883861332;6626.304238055128;7226.674799634135;7428.108626964583;7584.886226706714;8102.635381407733;11382.260153090354;13484.865151348753;13508.797368039292;13837.584872453843;13924.651883702989;11467.770644587228;11555.537778488766;11660.708482288012;11949.163558550817;11950.402479876146;8213.425060245725;9428.858567121362;11125.944370278097;11285.492152853305;11862.584809531625;11656;11771.411429428323;11802.114841387101;12010.699732506757;12114.515419383126;6109.75560977556;7625.6949722010495;7706.267904549059;7753.534787912743;7788.610569471617;8590.570471476527;11667.76664466689;11669.941650291694;12061.638150855488;12069.215500992408 10:17:08 INFO - PROCESS | 1638 | |3;mootools.html;1554.2384231726453;1567.3338830996825;1828.4423250908467;1917.7411049508312;1988.1649707123006;8712.782180445492;9226.67706630268;9230.123138301851;9231.123043310874;9248.260139188875;8101.91898081019;8315.875261871077;8324.33405327574;8464.576771161433;9052.321075919299;2230.5761905238032;2393.413613664655;2469.950600987979;2471.7775400213977;2483.8261321707487;2062.927797527087;2435.914742983996;2448;2458.2256589174444;2458.385403649079;2452.497238066201;2461.778439940405;2462.938426539333;2466.8766561671846;2469.345623409789;2434.330559096245;2469.962950555743;2470.1601455505215;2470.493548822487;2470.6170543565777;2030.3096947038077;2040.9285675001304;2437.890294936732;2438.4879175373017;2461.507698460315;9073.63705451781;9132.81734365309;9176.495292758895;9179;9187.989321174666;5404.486573775485;5581.469760372758;5616.887662246732;5619.971900140514;5635.8591035224035;3646.690031347339;3672.981635091807;3716.832742526593;3794.4118661607495;3800.2969450651717;1133.3086817041599;1134.5235001299475;1137.835013922985;1155.4684844971323;1167.3229526874393;12231;12355.25868447887;12393.380330983415;12395.75208495834;12396.504139834396;4784.282357646381;4854;4872.317875497433;4935.259711043301;4987.600991920638;10253.58985640566;10291.845622315672;10320.43237621938;10333.896661033445;10338.586456541805;5595.328560572757;5598.776048958078;5602.327720673546;5602.859928501739;5610.354809196913;5029.943711820485;5095.694258344512;5125.692458452505;5129.9230511542355;5131.10205714006;3530.9646903531147;4019.2162528307285;4079.2453396121814;4117.155983023533;4132.297509423405;1298.4222021200476;1298.7207750333723;1302.4529697526873;1314.5399110311505;1315.5461365828774;918.6325469812128;919.5907821019582;920.6133423961952;934.8878134623752;960.1838437328355;5729.312482502127;5745.741441635137;5917.112433135064;6124.050772130327;6169.105479705418;446.3327325648112;457.42364620577644;457.5447429807363;458.1775712595832;461.1238646571541;3943.211357728466;3995.141044675409;4028.254772867029;4071.7353372031316;4171.3325867860995;9341.579628916716;9399;10579.94710026445;11229.10167186623;11231.719207019727;10711.410872401937;11159.665210043711;11173.441327933571;11211.943940280247;11218.495167717472;8297.792555186048;8558.61486233121;8567.443116197428;8573.27127194183;8576.528290944058;5842.737076831638;5912.911306330495;5992.161097446448;6095.634261944298;6097.939020609737;9699.175570076623;10217.693469195936;10354.637587684394;10465.738356541147;10470.685879423629;10615.681529554126;10638.787224255317;10647.94676026615;10655.30740501865;10656.840147397641;6962.686679099554;7178.60517671533;7424.183339832722;7484;7627.466077374531;8577.785555361166;8610.827783444422;8713;8713.43362681449;8729.388942773945;7652.617369131633;7695.192004839411;7712.730054448068;7747.457677962489;7825.139234684067;7454.3663788576405;7518.210587888193;7531.623418828927;7570.772876813704;7572.3942084632;7048.682809273492;7092.148942126978;7178.318059784312;7183.102112235971;7184.8922266165;4992.400911890596;5001.8749531260555;5108.565771909281;5169.53474187325;5278.841634750964;4351;5124.692518448905;5127.4103478099005;5150.330457040711;5221 10:17:08 INFO - PROCESS | 1638 | |4;prototype.html;298.4895828133891;299.7017967122712;306.60907343137495;312.4064277872043;315.36611411063757;5242.21366794981;5429.429909859467;5482.616216864821;5525.723713814314;5546.4730850569185;4967.329410529586;5171.844844654666;5374.113271310229;5381.81163659272;5413.945860541394;3685.2076803487244;3881.9130643419817;4183.518895327046;4195.951012246938;4213.810378532958;3564.92870142597;3580.9615211588607;3852.383618621021;3978.3435733104;4201.634468797638;3456.2914602506426;4126.31915733905;4193.475815523059;4207.053412982085;4223.070924396628;3402.574678165229;3529.541159649255;4183.748975061506;4205.537390887;4235.597618226264;3516.310022832535;3572.7673952486352;3620.330238905811;3663.1757854482794;3681.1901381695984;4356.368326592658;4625.907481850378;5292.311999440087;5361.935654772901;5364.597655175839;3810.428435734634;4335.631471324909;4874.8537543873745;4890.266460031024;4904.4605093439695;4687.859364219079;5590;5663.405342439026;5787.594868359217;5793.681347525884;3848.9230215395814;4032.697547683906;4035.6771458283265;4048.9797551012352;4081.4694489566414;5004.774785134641;5543.558674744595;6015.699215039274;6054.364291749347;6083.695815209222;3773.9432958771586;3832.3676593362343;3860.2472517858746;4107.878012710302;4165.604267594574;3660.066682995819;4203.831846726097;4205.201011807808;4211.778584210545;4221.451211342506;4389.736615803062;4674.579287864109;4915.90168196634;4946.802127914915;4949.307097006422;4888.071266459361;5203.713795741271;5361.383440904268;5889.617174883619;5928.466438020599;1217.5190799634095;1344.2673742809995;1382.7234553089422;1384.9653758656113;1429.121090529317;791.6239786101555;854.7008547008621;863.3567991845989;865.6450855149359;870.9896520036854;4271.572842715766;4433.379326894237;4579.038401935564;4581.862544123682;4597.609203217764;4103.0663075900875;4227.8097485613225;4592.540745925381;4880.291897835729;4957.925631115536;3771.528558930134;3909.569947305794;4222.4299719538085;4556.521565235669;4571;2240.0959184693206;2745.339069862744;2844.4168945366564;3106.2389714520086;3137.733292670103;5606.55147588192;5867.618604790675;5954.005408188305;6189.257289125334;6229.221347331583;4707.741074240881;5192.4807519248525;6009.2188015557695;6107;6156.846078847975;5551.777928882881;6207.454943473154;6214.550924237002;6220.160278362454;6227.283862355887;4996.750162491933;5958.910616340671;5970.5223582114195;5974.922914698846;6003.219581454383;5374.596905232202;5411.458854114557;5591.692456914909;5661.377248502579;5788.681622510802;5152.793888244578;6209.627422354673;6212.440880320612;6227.314995350417;6229.750809967551;3365.495175723661;3912.7065470089287;3916.6279203475624;3950.656776695937;3954.406838974177;5597.832065038056;5613.971930140323;5733.684647344436;6066.545009124245;6066.908996364969;5117.692938423706;5698.8290351289525;5719.2279042328755;5847.26909136358;5880.852978675567;5851.71783004637;5855.677937713466;5881.647101173943;5906.586538942232;5913.645181289136;4691.390119284471;5240.659357141773;5265.657732247391;5552.278203833475;5732.656040637575;4712.905741885212;5411.810586629449;5820.576361964852;5847.39790793093;5882.470577648032;5095.286659867547;5672.808710170745;5704.344000440003;5708.743106560131;5720.2849643794525 10:17:08 INFO - PROCESS | 1638 | |5;yui.html;660.4023358860231;800.3957012455595;803.81512252182;840.9032961209463;870.577769781656;15528.689426211484;16082.83917160828;16711.749323760152;16843.578910527227;17085.48743537696;12313.569025084123;15281.388744450209;15297.923510382432;15306.158161301124;15311.23443827807;720.5064530796395;742.4802638153287;903.3631289940593;929.8279818233649;930.7952250504912;752.6725874244694;752.9811754706121;753.8266198774257;754.6113751418025;901.0358915959926;987.0622908237203;987.1855719031792;989.1938070472578;992.8510723391513;994.4878387630376;980.0493521284415;983.3706427886159;984.3503287830033;986.9407835529819;989;729.8503806719609;730.8209488675255;733.2484203691206;735.0995031086929;736.4550232827722;16477.505674829776;16481.587960300967;16620.750688739678;16632.33470661172;16650;11771.823422648667;13985;14045;14445.711085778226;15562;12913.418896149697;13071.673208169777;13095;13566.253856037914;13921.930390347983;4646.465656449518;4695.88260293492;4713.269443236304;4862.222044472903;4876.609871210295;126910.36544817218;129527.35236323852;131131.34434327862;131621;132186.33906830405;11480.425978701032;11789;12135.817962730565;12153.331566763913;12196.878031219574;19936.00319983995;23006.309810705705;23590.52818943646;23776.405589860045;23826.40433989164;8232.917670823335;8292.37807164465;8338.708145214889;8362.45644033136;8575.614097365633;4516.458025037016;4617.445906491175;4676.574075448747;4797.56821886032;4815.253635686474;3511.2626348466597;3655.049687081378;3656.2687462507606;3657.5062366580705;3661.7802931824176;697.6511744127936;697.7627606613675;698.4866123399297;706.0221593093603;709.2198581560242;571.5227784799739;654;700.579652208681;714.9204700901676;719.1478098453244;8396.706115285935;9261.823471484196;10001.49992500372;10049.59801607942;10248;682.9453643708491;691.1326285511651;691.2327316678483;697.7592730507967;728.5956294256738;3744.5506539215467;4143.91712165755;4849.466558678542;4883.145449546315;4990.451050384455;97441.51279243559;121053;134974.62563435992;160221;164010;112141.43929280301;125780.37109814392;128474;131348.3432582831;134175;105061.36796949542;118165;120584.39707801405;121933;122188.77811221774;9249.815003699754;9512.38169518979;9549.331546791936;9565.713028609152;9613.615455381987;66599;67152.66423667851;67953.64092718216;68675.62648746897;68887.27781805495;104206;105387;105529.944700552;108241;109052;12253.69365765863;12369;12463.750724985268;12676.619701408972;12760.106792524433;13462.798058028942;13595.048346615642;13595.320233988063;13794;13815.516456923959;12152.966997805286;12154.635360939186;12505.499780009062;13103.475860965455;13225.537106201236;11991.22057066288;12657.493700252255;12722.61832145037;12732.809007865075;13290.86709132935;11906.642800715992;12149.392530373623;12153.210041347284;12184.51261949512;12255.32595707209;10304.845427318447;10395.32430392022;10439.739006524898;11203.327800332007;11247.606333778278;10869.29349592274;10971.83542246851;11110.833337500106;11121.332720036824;11161.330320180816 10:17:08 INFO - PROCESS | 1638 | __end_tp_report 10:17:08 INFO - PROCESS | 1638 | __start_cc_report 10:17:08 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1298 10:17:08 INFO - PROCESS | 1638 | __end_cc_report 10:17:08 INFO - PROCESS | 1638 | __startTimestamp1479406628208__endTimestamp 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:17:08 INFO - PROCESS | 1638 | Number of tests: 6 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5825.60 Median:6130.79 stddev:655.16 (10.7%) stddev-sans-first:611.00 10:17:08 INFO - PROCESS | 1638 | Values: 2745.7 3471.5 3472.3 3516.2 3549.0 5839.9 5880.2 5910.4 5946.0 5988.2 4968.2 5096.0 5912.3 5948.7 5962.3 5303.1 5322.7 5331.8 5372.9 5379.4 5245.3 5246.9 5278.6 5398.9 5429.5 5315.1 5319.2 5320.2 5322.4 5350.0 5318.3 5323.8 5403.3 5403.6 5412.8 5187.7 5258.6 5348.6 5356.3 5373.5 5717.6 5754.6 5764.5 5824.4 5841.2 6211.9 6270.3 6288.2 6293.7 6327.8 6239.4 6271.7 6281.7 6291.3 6326.9 5774.9 5776.3 5815.2 5832.3 5834.8 6313.4 6331.7 6338.5 6352.2 6360.5 6238.4 6243.6 6246.7 6247.7 6249.8 6182.9 6193.3 6256.3 6314.0 6342.3 5627.6 5976.0 6218.8 6283.2 6347.9 6226.7 6294.4 6304.4 6312.7 6321.7 4964.3 5038.1 5045.5 5065.7 5066.0 4506.6 4515.1 4561.4 4589.4 4594.3 4859.4 5958.1 5984.3 6073.1 6121.8 6233.8 6241.4 6290.0 6303.0 6305.5 5852.9 6022.7 6030.6 6047.5 6068.0 5486.8 5490.0 5529.0 5531.6 5536.4 6475.8 6479.6 6488.3 6497.1 6505.4 6244.8 6262.7 6265.2 6266.0 6267.9 6277.7 6306.7 6342.9 6345.7 6386.9 6287.9 6296.9 6310.6 6321.6 6322.9 6246.4 6259.5 6263.2 6271.8 6275.4 5297.2 6134.9 6145.5 6239.2 6284.9 4988.1 6245.6 6263.0 6277.3 6309.1 6130.8 6137.0 6144.2 6147.3 6153.4 6123.7 6157.4 6234.0 6293.2 6298.1 6071.9 6082.8 6143.7 6169.3 6177.8 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:76691.16 Median:36997.63 stddev:173227.92 (468.2%) stddev-sans-first:173619.39 10:17:08 INFO - PROCESS | 1638 | Values: 488.9 495.7 541.8 543.9 548.9 31998.0 41931.4 43564.3 43617.6 45524.1 45346.3 45700.8 45740.9 45752.7 45998.0 9990.0 10180.9 10181.0 10197.3 10244.6 9382.0 9614.9 9620.3 9712.4 9717.5 12303.8 12575.6 12583.2 12740.9 12742.6 12534.4 12629.2 12636.0 12637.3 12644.0 12400.9 12486.2 12488.5 12490.5 12496.7 42333.0 42558.8 42746.1 42795.1 42890.8 3457.4 3478.8 3602.3 3619.9 3788.2 32361.7 32536.0 32629.5 32630.7 32718.5 3300.0 3353.4 3409.6 3426.7 3502.6 534801.0 537189.0 537288.0 537473.0 538000.0 35168.5 62535.0 62988.4 63102.0 63192.7 35772.0 37099.6 37173.8 37185.4 37201.8 15686.0 15838.5 15840.3 15848.4 15861.0 13208.9 13310.8 13322.3 13327.7 13328.1 6578.2 7553.0 7692.3 8108.1 8173.6 3400.8 3413.4 3430.0 3430.2 3454.6 991.1 1022.7 1023.6 1067.9 1115.8 30715.8 30757.8 30963.5 31593.4 31625.7 1086.2 1113.7 1134.6 1144.3 1191.4 16214.6 16377.9 16399.3 16492.7 16532.5 694848.5 714256.0 714872.0 717253.0 717607.2 61348.0 61791.0 61801.0 61817.0 61867.1 1489.5 1490.1 1496.2 1530.3 1535.1 28981.0 30363.5 30409.8 30704.9 30907.2 54200.0 55056.7 55081.0 55119.2 55131.7 670058.0 677095.0 677421.0 679809.6 680136.0 36725.0 44551.6 44927.0 45101.8 47045.5 47806.3 48807.0 49256.5 49402.5 49897.8 40235.8 40522.8 41400.4 41593.4 42301.8 40730.0 41062.2 41126.4 41200.0 42305.0 37471.4 37532.4 37652.9 37671.8 40594.0 31518.8 32773.7 35937.0 36652.6 36895.6 27022.3 27242.7 27338.2 27351.6 27574.0 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35712.85 Median:2376.18 stddev:107497.88 (4524.0%) stddev-sans-first:107766.63 10:17:08 INFO - PROCESS | 1638 | Values: 340.5 364.7 377.7 381.2 411.2 17744.8 19607.3 21151.7 21233.8 22048.2 11905.5 12126.3 12334.1 12334.6 12356.4 5309.5 5629.2 5633.2 5634.8 5640.9 4095.3 4142.0 4165.7 4207.6 5539.9 5599.7 6001.4 6146.4 6235.4 6264.7 6120.4 6868.3 6928.1 6932.3 6946.7 5259.1 5545.6 6125.5 6132.8 6147.5 13665.8 13722.5 13845.4 13908.7 13925.4 2127.8 2371.7 2380.7 2432.2 2569.4 10158.2 10242.6 10254.0 10631.6 10730.0 1694.9 1988.1 1994.5 2004.6 2024.5 117072.0 118955.0 123024.0 123955.4 128898.4 9322.3 11196.7 11597.0 11643.4 11722.6 14490.2 14527.3 14528.3 14542.9 14552.9 8167.2 8395.0 8498.9 8529.8 8611.5 6894.4 8204.3 8275.1 8445.7 8546.9 4378.6 4448.6 4480.8 4510.4 4526.0 1813.9 1834.9 1849.7 1905.2 1956.2 900.1 929.8 931.9 959.2 1007.6 20977.6 21713.3 22013.9 22111.3 22193.9 946.9 965.9 985.8 1013.4 1031.8 10911.0 11569.7 11635.9 11658.3 11673.8 613408.0 633604.0 650616.0 666137.0 666588.0 59385.4 77970.2 136281.3 137325.6 138476.3 875.9 963.7 994.6 1018.9 1020.5 13774.7 18220.5 18540.9 19612.7 20172.2 57061.1 57270.0 58324.1 59704.0 60440.0 79887.0 80775.6 81904.8 84763.6 86116.1 6626.3 7226.7 7428.1 7584.9 8102.6 11382.3 13484.9 13508.8 13837.6 13924.7 11467.8 11555.5 11660.7 11949.2 11950.4 8213.4 9428.9 11125.9 11285.5 11862.6 11656.0 11771.4 11802.1 12010.7 12114.5 6109.8 7625.7 7706.3 7753.5 7788.6 8590.6 11667.8 11669.9 12061.6 12069.2 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5866.09 Median:4903.79 stddev:3316.82 (67.6%) stddev-sans-first:3310.30 10:17:08 INFO - PROCESS | 1638 | Values: 1554.2 1567.3 1828.4 1917.7 1988.2 8712.8 9226.7 9230.1 9231.1 9248.3 8101.9 8315.9 8324.3 8464.6 9052.3 2230.6 2393.4 2470.0 2471.8 2483.8 2062.9 2435.9 2448.0 2458.2 2458.4 2452.5 2461.8 2462.9 2466.9 2469.3 2434.3 2470.0 2470.2 2470.5 2470.6 2030.3 2040.9 2437.9 2438.5 2461.5 9073.6 9132.8 9176.5 9179.0 9188.0 5404.5 5581.5 5616.9 5620.0 5635.9 3646.7 3673.0 3716.8 3794.4 3800.3 1133.3 1134.5 1137.8 1155.5 1167.3 12231.0 12355.3 12393.4 12395.8 12396.5 4784.3 4854.0 4872.3 4935.3 4987.6 10253.6 10291.8 10320.4 10333.9 10338.6 5595.3 5598.8 5602.3 5602.9 5610.4 5029.9 5095.7 5125.7 5129.9 5131.1 3531.0 4019.2 4079.2 4117.2 4132.3 1298.4 1298.7 1302.5 1314.5 1315.5 918.6 919.6 920.6 934.9 960.2 5729.3 5745.7 5917.1 6124.1 6169.1 446.3 457.4 457.5 458.2 461.1 3943.2 3995.1 4028.3 4071.7 4171.3 9341.6 9399.0 10579.9 11229.1 11231.7 10711.4 11159.7 11173.4 11211.9 11218.5 8297.8 8558.6 8567.4 8573.3 8576.5 5842.7 5912.9 5992.2 6095.6 6097.9 9699.2 10217.7 10354.6 10465.7 10470.7 10615.7 10638.8 10647.9 10655.3 10656.8 6962.7 7178.6 7424.2 7484.0 7627.5 8577.8 8610.8 8713.0 8713.4 8729.4 7652.6 7695.2 7712.7 7747.5 7825.1 7454.4 7518.2 7531.6 7570.8 7572.4 7048.7 7092.1 7178.3 7183.1 7184.9 4992.4 5001.9 5108.6 5169.5 5278.8 4351.0 5124.7 5127.4 5150.3 5221.0 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4567.52 Median:4953.62 stddev:1437.44 (29.0%) stddev-sans-first:1405.30 10:17:08 INFO - PROCESS | 1638 | Values: 298.5 299.7 306.6 312.4 315.4 5242.2 5429.4 5482.6 5525.7 5546.5 4967.3 5171.8 5374.1 5381.8 5413.9 3685.2 3881.9 4183.5 4196.0 4213.8 3564.9 3581.0 3852.4 3978.3 4201.6 3456.3 4126.3 4193.5 4207.1 4223.1 3402.6 3529.5 4183.7 4205.5 4235.6 3516.3 3572.8 3620.3 3663.2 3681.2 4356.4 4625.9 5292.3 5361.9 5364.6 3810.4 4335.6 4874.9 4890.3 4904.5 4687.9 5590.0 5663.4 5787.6 5793.7 3848.9 4032.7 4035.7 4049.0 4081.5 5004.8 5543.6 6015.7 6054.4 6083.7 3773.9 3832.4 3860.2 4107.9 4165.6 3660.1 4203.8 4205.2 4211.8 4221.5 4389.7 4674.6 4915.9 4946.8 4949.3 4888.1 5203.7 5361.4 5889.6 5928.5 1217.5 1344.3 1382.7 1385.0 1429.1 791.6 854.7 863.4 865.6 871.0 4271.6 4433.4 4579.0 4581.9 4597.6 4103.1 4227.8 4592.5 4880.3 4957.9 3771.5 3909.6 4222.4 4556.5 4571.0 2240.1 2745.3 2844.4 3106.2 3137.7 5606.6 5867.6 5954.0 6189.3 6229.2 4707.7 5192.5 6009.2 6107.0 6156.8 5551.8 6207.5 6214.6 6220.2 6227.3 4996.8 5958.9 5970.5 5974.9 6003.2 5374.6 5411.5 5591.7 5661.4 5788.7 5152.8 6209.6 6212.4 6227.3 6229.8 3365.5 3912.7 3916.6 3950.7 3954.4 5597.8 5614.0 5733.7 6066.5 6066.9 5117.7 5698.8 5719.2 5847.3 5880.9 5851.7 5855.7 5881.6 5906.6 5913.6 4691.4 5240.7 5265.7 5552.3 5732.7 4712.9 5411.8 5820.6 5847.4 5882.5 5095.3 5672.8 5704.3 5708.7 5720.3 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:25875.25 Median:16964.53 stddev:41242.47 (243.1%) stddev-sans-first:41314.71 10:17:08 INFO - PROCESS | 1638 | Values: 660.4 800.4 803.8 840.9 870.6 15528.7 16082.8 16711.7 16843.6 17085.5 12313.6 15281.4 15297.9 15306.2 15311.2 720.5 742.5 903.4 929.8 930.8 752.7 753.0 753.8 754.6 901.0 987.1 987.2 989.2 992.9 994.5 980.0 983.4 984.4 986.9 989.0 729.9 730.8 733.2 735.1 736.5 16477.5 16481.6 16620.8 16632.3 16650.0 11771.8 13985.0 14045.0 14445.7 15562.0 12913.4 13071.7 13095.0 13566.3 13921.9 4646.5 4695.9 4713.3 4862.2 4876.6 126910.4 129527.4 131131.3 131621.0 132186.3 11480.4 11789.0 12135.8 12153.3 12196.9 19936.0 23006.3 23590.5 23776.4 23826.4 8232.9 8292.4 8338.7 8362.5 8575.6 4516.5 4617.4 4676.6 4797.6 4815.3 3511.3 3655.0 3656.3 3657.5 3661.8 697.7 697.8 698.5 706.0 709.2 571.5 654.0 700.6 714.9 719.1 8396.7 9261.8 10001.5 10049.6 10248.0 682.9 691.1 691.2 697.8 728.6 3744.6 4143.9 4849.5 4883.1 4990.5 97441.5 121053.0 134974.6 160221.0 164010.0 112141.4 125780.4 128474.0 131348.3 134175.0 105061.4 118165.0 120584.4 121933.0 122188.8 9249.8 9512.4 9549.3 9565.7 9613.6 66599.0 67152.7 67953.6 68675.6 68887.3 104206.0 105387.0 105529.9 108241.0 109052.0 12253.7 12369.0 12463.8 12676.6 12760.1 13462.8 13595.0 13595.3 13794.0 13815.5 12153.0 12154.6 12505.5 13103.5 13225.5 11991.2 12657.5 12722.6 12732.8 13290.9 11906.6 12149.4 12153.2 12184.5 12255.3 10304.8 10395.3 10439.7 11203.3 11247.6 10869.3 10971.8 11110.8 11121.3 11161.3 10:17:08 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:17:08 INFO - PROCESS | 1638 | 10:17:08 INFO - TEST-INFO | 1638: exit 0 10:17:08 INFO - TEST-OK | dromaeo_css | took 1114928ms 10:17:08 INFO - TEST-START | kraken 10:17:08 INFO - operating with platform_type : mac_ 10:17:08 INFO - Initialising browser for kraken test... 10:17:08 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmp9r19Vz/profile http://localhost:49246/getInfo.html) 10:17:10 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:17:10 INFO - PROCESS | 1648 | colorDepth:24 10:17:10 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:17:10 INFO - PROCESS | 1648 | __metrics 10:17:10 INFO - PROCESS | 1648 | 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" 10:17:10 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:11 INFO - TEST-INFO | 1648: exit 0 10:17:11 INFO - Browser initialized. 10:17:11 INFO - Running cycle 1/1 for kraken test... 10:17:11 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmp9r19Vz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:23 INFO - PROCESS | 1650 | RSS: Main: 168198144 10:17:23 INFO - PROCESS | 1650 | 10:17:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:27 INFO - PROCESS | 1650 | RSS: Main: 218681344 10:17:27 INFO - PROCESS | 1650 | 10:17:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 10:17:30 INFO - PROCESS | 1650 | RSS: Main: 229597184 10:17:30 INFO - PROCESS | 1650 | 10:17:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 10:17:33 INFO - PROCESS | 1650 | RSS: Main: 327708672 10:17:33 INFO - PROCESS | 1650 | 10:17:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 10:17:36 INFO - PROCESS | 1650 | RSS: Main: 227983360 10:17:36 INFO - PROCESS | 1650 | 10:17:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:39 INFO - PROCESS | 1650 | RSS: Main: 229961728 10:17:39 INFO - PROCESS | 1650 | 10:17:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:42 INFO - PROCESS | 1650 | RSS: Main: 267214848 10:17:42 INFO - PROCESS | 1650 | 10:17:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:45 INFO - PROCESS | 1650 | RSS: Main: 266850304 10:17:45 INFO - PROCESS | 1650 | 10:17:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 10:17:49 INFO - PROCESS | 1650 | RSS: Main: 267509760 10:17:49 INFO - PROCESS | 1650 | 10:17:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:51 INFO - PROCESS | 1650 | RSS: Main: 240869376 10:17:51 INFO - PROCESS | 1650 | 10:17:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:53 INFO - PROCESS | 1650 | RSS: Main: 245309440 10:17:53 INFO - PROCESS | 1650 | 10:17:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:56 INFO - PROCESS | 1650 | RSS: Main: 249868288 10:17:56 INFO - PROCESS | 1650 | 10:17:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:00 INFO - PROCESS | 1650 | RSS: Main: 276746240 10:18:00 INFO - PROCESS | 1650 | 10:18:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:03 INFO - PROCESS | 1650 | RSS: Main: 265449472 10:18:03 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 10:18:05 INFO - PROCESS | 1650 | RSS: Main: 309387264 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | __start_tp_report 10:18:05 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:18:05 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:18:05 INFO - PROCESS | 1650 | |i|pagename|runs| 10:18:05 INFO - PROCESS | 1650 | |0;ai-astar;112;114;114;115;114;114;114;114;115;114 10:18:05 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;109;106;141;110;107;106;106;163;135 10:18:05 INFO - PROCESS | 1650 | |2;audio-dft;183;183;182;182;182;182;183;182;182;181 10:18:05 INFO - PROCESS | 1650 | |3;audio-fft;79;61;70;102;79;83;81;67;81;56 10:18:05 INFO - PROCESS | 1650 | |4;audio-oscillator;85;72;94;69;68;68;93;67;67;88 10:18:05 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;86;91;88;89;86;91;87;89;86 10:18:05 INFO - PROCESS | 1650 | |6;imaging-darkroom;97;97;97;97;97;98;97;97;97;97 10:18:05 INFO - PROCESS | 1650 | |7;imaging-desaturate;83;84;83;84;84;83;83;84;83;84 10:18:05 INFO - PROCESS | 1650 | |8;json-parse-financial;55;54;52;52;55;57;55;55;55;55 10:18:05 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;76;75;74;74;69;70;71;71;72 10:18:05 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;84;85;83;83;84;81;82;83;88;99 10:18:05 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;137;139;130;124;156;145;145;135;141;158 10:18:05 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;162;160;162;161;162;161;160;157;160;159 10:18:05 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;67;67;66;66;66;64;65;65;65 10:18:05 INFO - PROCESS | 1650 | __end_tp_report 10:18:05 INFO - PROCESS | 1650 | __start_cc_report 10:18:05 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1916 10:18:05 INFO - PROCESS | 1650 | __end_cc_report 10:18:05 INFO - PROCESS | 1650 | __startTimestamp1479406685557__endTimestamp 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:18:05 INFO - PROCESS | 1650 | Number of tests: 14 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 10:18:05 INFO - PROCESS | 1650 | Values: 112.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:122.50 stddev:20.86 (17.0%) stddev-sans-first:20.89 10:18:05 INFO - PROCESS | 1650 | Values: 142.0 109.0 106.0 141.0 110.0 107.0 106.0 106.0 163.0 135.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.20 Median:182.00 stddev:0.63 (0.3%) stddev-sans-first:0.60 10:18:05 INFO - PROCESS | 1650 | Values: 183.0 183.0 182.0 182.0 182.0 182.0 183.0 182.0 182.0 181.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:75.90 Median:79.00 stddev:13.06 (16.5%) stddev-sans-first:13.80 10:18:05 INFO - PROCESS | 1650 | Values: 79.0 61.0 70.0 102.0 79.0 83.0 81.0 67.0 81.0 56.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.50 stddev:11.45 (14.6%) stddev-sans-first:11.79 10:18:05 INFO - PROCESS | 1650 | Values: 85.0 72.0 94.0 69.0 68.0 68.0 93.0 67.0 67.0 88.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:1.93 (2.2%) stddev-sans-first:2.03 10:18:05 INFO - PROCESS | 1650 | Values: 89.0 86.0 91.0 88.0 89.0 86.0 91.0 87.0 89.0 86.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:97.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:18:05 INFO - PROCESS | 1650 | Values: 97.0 97.0 97.0 97.0 97.0 98.0 97.0 97.0 97.0 97.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:83.50 Median:84.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:18:05 INFO - PROCESS | 1650 | Values: 83.0 84.0 83.0 84.0 84.0 83.0 83.0 84.0 83.0 84.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.51 (2.7%) stddev-sans-first:1.59 10:18:05 INFO - PROCESS | 1650 | Values: 55.0 54.0 52.0 52.0 55.0 57.0 55.0 55.0 55.0 55.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:73.00 stddev:3.50 (4.8%) stddev-sans-first:2.40 10:18:05 INFO - PROCESS | 1650 | Values: 64.0 76.0 75.0 74.0 74.0 69.0 70.0 71.0 71.0 72.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.00 stddev:5.20 (6.2%) stddev-sans-first:5.50 10:18:05 INFO - PROCESS | 1650 | Values: 84.0 85.0 83.0 83.0 84.0 81.0 82.0 83.0 88.0 99.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:143.00 stddev:10.60 (7.4%) stddev-sans-first:11.15 10:18:05 INFO - PROCESS | 1650 | Values: 137.0 139.0 130.0 124.0 156.0 145.0 145.0 135.0 141.0 158.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.00 stddev:1.58 (1.0%) stddev-sans-first:1.56 10:18:05 INFO - PROCESS | 1650 | Values: 162.0 160.0 162.0 161.0 162.0 161.0 160.0 157.0 160.0 159.0 10:18:05 INFO - PROCESS | 1650 | 10:18:05 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 10:18:05 INFO - PROCESS | 1650 | Values: 65.0 67.0 67.0 66.0 66.0 66.0 64.0 65.0 65.0 65.0 10:18:05 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:18:05 INFO - PROCESS | 1650 | 10:18:06 INFO - TEST-INFO | 1650: exit 0 10:18:06 INFO - TEST-OK | kraken | took 57588ms 10:18:06 INFO - SUITE-END | took 1172s 10:18:06 INFO - Completed test suite (00:19:32) 10:18:06 INFO - javascript benchmark 10:18:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2745.7254274572556, 3471.4792781082842, 3472.2534655049158, 3516.1561225305904, 3549.041758725144, 5839.9124013139835, 5880.2355693759855, 5910.438508341711, 5945.9891818390815, 5988.221531200948, 4968.180250258703, 5096.031753966744, 5912.290525136989, 5948.702564871761, 5962.344142144371, 5303.098473259555, 5322.654027488211, 5331.813386531472, 5372.946270537283, 5379.35447746271, 5245.344331958505, 5246.9212961805415, 5278.577713782888, 5398.8920221595545, 5429.4570542945585, 5315.0698627740185, 5319.20211968206, 5320.17537281722, 5322.4411436799155, 5350.0, 5318.30861987943, 5323.840284791462, 5403.2705584745945, 5403.594730395236, 5412.83761487156, 5187.714675692835, 5258.605604579634, 5348.625596208267, 5356.250124982505, 5373.489518495776, 5717.571182161355, 5754.568407369464, 5764.452377024176, 5824.359320474744, 5841.153032810261, 6211.9068213976825, 6270.341614130496, 6288.151099601541, 6293.653849038301, 6327.81016569499, 6239.407256310643, 6271.749130034793, 6281.685915704196, 6291.276503202099, 6326.93673063268, 5774.855628609276, 5776.277965254343, 5815.156802263648, 5832.300123985149, 5834.824955251349, 6313.40022697843, 6331.651759153198, 6338.524610654127, 6352.237731472253, 6360.52296077796, 6238.376162383816, 6243.594166379171, 6246.656433896089, 6247.718852651642, 6249.812505624838, 6182.938170618326, 6193.287771906198, 6256.280527739368, 6314.0, 6342.334054924167, 5627.5779316551425, 5976.013957697019, 6218.751249949952, 6283.183186185766, 6347.904781428282, 6226.719797609118, 6294.370562943669, 6304.401081897213, 6312.652804095727, 6321.65230912295, 4964.304997300381, 5038.1183292924325, 5045.495450454999, 5065.670731402447, 5065.974670126626, 4506.616937560344, 4515.1195516873895, 4561.384213131251, 4589.403377560896, 4594.333821595917, 4859.3682821233015, 5958.106284057426, 5984.311804142492, 6073.08903664445, 6121.755129794758, 6233.750649974041, 6241.407066328691, 6289.968550157311, 6303.0, 6305.527085468608, 5852.882942341214, 6022.698865056817, 6030.6080104793045, 6047.546434017467, 6067.969660151759, 5486.835394938158, 5489.972550137224, 5529.0324193266015, 5531.612787104864, 5536.4186760390385, 6475.838104047437, 6479.611223326427, 6488.2538508072175, 6497.122888410004, 6505.381988711065, 6244.812655620339, 6262.749490020348, 6265.248170219421, 6265.96867015662, 6267.874642507216, 6277.74889004453, 6306.747730090929, 6342.904856427065, 6345.682715864281, 6386.904196436964, 6287.937120628918, 6296.937030629635, 6310.5898116622275, 6321.589096708699, 6322.936770632235, 6246.406591373812, 6259.467945224525, 6263.248410190807, 6271.843203919939, 6275.435210831047, 5297.152455607084, 6134.9079763804475, 6145.508359331332, 6239.188905442264, 6284.905726414016, 4988.077205716954, 6245.6252624842655, 6263.0, 6277.278113016879, 6309.05364195356, 6130.785422510191, 6137.048757442603, 6144.170536977451, 6147.262328520606, 6153.4154255345675, 6123.7244324006415, 6157.4458298753325, 6233.96883015582, 6293.181886354744, 6298.11826344303, 6071.878562428815, 6082.787102451393, 6143.72353244114, 6169.321374648695, 6177.752889884354], "value": 5784.43212739241, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.93643826302576, 495.68276303166004, 541.7643325153557, 543.945605439456, 548.8984537860493, 31998.0, 41931.371029434544, 43564.346534802, 43617.56382436175, 45524.089518209614, 45346.31980520295, 45700.77149614247, 45740.85647858797, 45752.71236438173, 45998.01012934157, 9990.0, 10180.898191018106, 10181.0, 10197.337173083726, 10244.590216391336, 9382.0, 9614.855777163348, 9620.326577139567, 9712.417254964725, 9717.46553939533, 12303.815442768366, 12575.622731318075, 12583.245005299666, 12740.93629531851, 12742.55401060963, 12534.435950382254, 12629.179103358298, 12636.0, 12637.304948227844, 12644.0, 12400.945919596756, 12486.188397754117, 12488.50045998168, 12490.50037998479, 12496.687582810502, 42333.0, 42558.787206063775, 42746.1450770986, 42795.144097118195, 42890.78554607207, 3457.360388328167, 3478.7912725236315, 3602.279544091166, 3619.855205791765, 3788.22341420011, 32361.676383236336, 32536.0, 32629.51055734166, 32630.673693263238, 32718.509222361685, 3299.983500082484, 3353.4299169141304, 3409.6419875913166, 3426.691597756214, 3502.562179727534, 534801.0, 537189.0, 537288.0, 537473.0, 538000.0, 35168.47247291293, 62535.0, 62988.370116299164, 63102.0, 63192.684036580446, 35772.0, 37099.62900370962, 37173.81413092971, 37185.44221836675, 37201.81399092987, 15686.0, 15838.52484425469, 15840.287187076608, 15848.366065357488, 15861.0, 13208.867911320764, 13310.800337994939, 13322.267275299757, 13327.666808329675, 13328.06703530763, 6578.243501997236, 7553.0, 7692.307692307719, 8108.108108108104, 8173.632186551619, 3400.795952242873, 3413.4367829307885, 3430.0, 3430.1767575781632, 3454.6199918008997, 991.0782971836262, 1022.6829682798208, 1023.559869256227, 1067.8558394616628, 1115.765689205276, 30715.8464207682, 30757.84621076925, 30963.45182740854, 31593.36813263768, 31625.683743162735, 1086.2450596835124, 1113.6881673131536, 1134.6271012075317, 1144.336284954741, 1191.4102519253024, 16214.594635134215, 16377.918110409371, 16399.262033208535, 16492.670146597, 16532.46915119033, 694848.5257573781, 714256.0, 714872.0, 717253.0, 717607.2358914621, 61348.0, 61791.0, 61801.0, 61817.0, 61867.07199392013, 1489.47868246113, 1490.1431676786108, 1496.2369191712305, 1530.3037118111233, 1535.1403214200084, 28981.0, 30363.544546832258, 30409.847950760104, 30704.925327613426, 30907.227319317197, 54200.0, 55056.724716376164, 55081.0, 55119.173212401045, 55131.72434137804, 670058.0, 677095.0, 677421.0, 679809.6009519921, 680136.0, 36725.0, 44551.554484456035, 44927.0, 45101.77449112733, 47045.52954470548, 47806.28290575575, 48807.0, 49256.507434925195, 49402.50597493979, 49897.75051124721, 40235.79882100688, 40522.79738601406, 41400.37899431451, 41593.37609935914, 42301.78849105735, 40730.0, 41062.17875642411, 41126.383104254055, 41199.97000075022, 42305.0, 37471.43792843164, 37532.437013445364, 37652.87041388763, 37671.81164094162, 40594.0, 31518.842405787826, 32773.67226327706, 35937.0, 36652.63347366599, 36895.631043689216, 27022.26557445574, 27242.727572724812, 27338.179854604394, 27351.58972615452, 27574.0], "value": 20317.438155064414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4773672412847, 364.6717953841542, 377.65821931152317, 381.1975790960029, 411.23099803367705, 17744.82255177448, 19607.313744018964, 21151.682724759143, 21233.787662123374, 22048.228312009083, 11905.464254108565, 12126.272423654587, 12334.136610437274, 12334.568290109848, 12356.443960021797, 5309.539876533955, 5629.155626656014, 5633.211350410946, 5634.802781902634, 5640.858978525549, 4095.262852686515, 4141.9585804142025, 4165.66674666026, 4207.579242075783, 5539.861503462405, 5599.692016939067, 6001.429864162919, 6146.354632763562, 6235.376462353751, 6264.686765661721, 6120.357362476942, 6868.313168683117, 6928.064711263965, 6932.272111428278, 6946.687399067054, 5259.132243179871, 5545.611807173499, 6125.540584456184, 6132.7546898124465, 6147.538934579924, 13665.795013074812, 13722.519711810039, 13845.446182152802, 13908.721825563433, 13925.373358198905, 2127.8297736181066, 2371.679823223877, 2380.678608387863, 2432.2095319021387, 2569.4218800769863, 10158.187345012455, 10242.590296388136, 10254.0, 10631.627893023708, 10730.0, 1694.93220271189, 1988.0556735550642, 1994.5113447205383, 2004.5589970206531, 2024.5242368043498, 117072.0, 118955.0, 123024.0, 123955.38022309922, 128898.3555082228, 9322.25421966241, 11196.66410007701, 11597.014253788522, 11643.359615221245, 11722.648320550397, 14490.203038832755, 14527.346269417902, 14528.346224419927, 14542.909281803906, 14552.927235363755, 8167.224113709188, 8394.958025209835, 8498.872516912252, 8529.786755331043, 8611.50266422743, 6894.413974812197, 8204.343652507785, 8275.131111233233, 8445.662173513114, 8546.871796923051, 4378.634705062572, 4448.621867141329, 4480.820767169342, 4510.368548403226, 4525.954740452619, 1813.9002354870609, 1834.908254587292, 1849.704047352417, 1905.1993569452882, 1956.178405069874, 900.1223806788329, 929.8233335666337, 931.897491275959, 959.2230293462318, 1007.5768177365524, 20977.580448390945, 21713.348599542038, 22013.889930550245, 22111.336659899905, 22193.89030548466, 946.8958414574391, 965.8502932045544, 985.8422652375729, 1013.381837079381, 1031.8039572481205, 10910.963458471433, 11569.710757230969, 11635.894590013935, 11658.300501969909, 11673.824892626617, 613408.0, 633604.0, 650616.0, 666137.0, 666588.0, 59385.406145938854, 77970.2202977963, 136281.3185934084, 137325.62674373327, 138476.30761846126, 875.9386842921061, 963.7471287326588, 994.6319861651091, 1018.8675472188717, 1020.5407566595062, 13774.725329257823, 18220.544486387415, 18540.907295463436, 19612.705809412586, 20172.193112275345, 57061.144082837964, 57270.0, 58324.125138122115, 59704.0, 60440.0, 79887.0, 80775.59612201901, 81904.77142842743, 84763.57618212116, 86116.13883861332, 6626.304238055128, 7226.674799634135, 7428.108626964583, 7584.886226706714, 8102.635381407733, 11382.260153090354, 13484.865151348753, 13508.797368039292, 13837.584872453843, 13924.651883702989, 11467.770644587228, 11555.537778488766, 11660.708482288012, 11949.163558550817, 11950.402479876146, 8213.425060245725, 9428.858567121362, 11125.944370278097, 11285.492152853305, 11862.584809531625, 11656.0, 11771.411429428323, 11802.114841387101, 12010.699732506757, 12114.515419383126, 6109.75560977556, 7625.6949722010495, 7706.267904549059, 7753.534787912743, 7788.610569471617, 8590.570471476527, 11667.76664466689, 11669.941650291694, 12061.638150855488, 12069.215500992408], "value": 9282.227473843066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.2384231726453, 1567.3338830996825, 1828.4423250908467, 1917.7411049508312, 1988.1649707123006, 8712.782180445492, 9226.67706630268, 9230.123138301851, 9231.123043310874, 9248.260139188875, 8101.91898081019, 8315.875261871077, 8324.33405327574, 8464.576771161433, 9052.321075919299, 2230.5761905238032, 2393.413613664655, 2469.950600987979, 2471.7775400213977, 2483.8261321707487, 2062.927797527087, 2435.914742983996, 2448.0, 2458.2256589174444, 2458.385403649079, 2452.497238066201, 2461.778439940405, 2462.938426539333, 2466.8766561671846, 2469.345623409789, 2434.330559096245, 2469.962950555743, 2470.1601455505215, 2470.493548822487, 2470.6170543565777, 2030.3096947038077, 2040.9285675001304, 2437.890294936732, 2438.4879175373017, 2461.507698460315, 9073.63705451781, 9132.81734365309, 9176.495292758895, 9179.0, 9187.989321174666, 5404.486573775485, 5581.469760372758, 5616.887662246732, 5619.971900140514, 5635.8591035224035, 3646.690031347339, 3672.981635091807, 3716.832742526593, 3794.4118661607495, 3800.2969450651717, 1133.3086817041599, 1134.5235001299475, 1137.835013922985, 1155.4684844971323, 1167.3229526874393, 12231.0, 12355.25868447887, 12393.380330983415, 12395.75208495834, 12396.504139834396, 4784.282357646381, 4854.0, 4872.317875497433, 4935.259711043301, 4987.600991920638, 10253.58985640566, 10291.845622315672, 10320.43237621938, 10333.896661033445, 10338.586456541805, 5595.328560572757, 5598.776048958078, 5602.327720673546, 5602.859928501739, 5610.354809196913, 5029.943711820485, 5095.694258344512, 5125.692458452505, 5129.9230511542355, 5131.10205714006, 3530.9646903531147, 4019.2162528307285, 4079.2453396121814, 4117.155983023533, 4132.297509423405, 1298.4222021200476, 1298.7207750333723, 1302.4529697526873, 1314.5399110311505, 1315.5461365828774, 918.6325469812128, 919.5907821019582, 920.6133423961952, 934.8878134623752, 960.1838437328355, 5729.312482502127, 5745.741441635137, 5917.112433135064, 6124.050772130327, 6169.105479705418, 446.3327325648112, 457.42364620577644, 457.5447429807363, 458.1775712595832, 461.1238646571541, 3943.211357728466, 3995.141044675409, 4028.254772867029, 4071.7353372031316, 4171.3325867860995, 9341.579628916716, 9399.0, 10579.94710026445, 11229.10167186623, 11231.719207019727, 10711.410872401937, 11159.665210043711, 11173.441327933571, 11211.943940280247, 11218.495167717472, 8297.792555186048, 8558.61486233121, 8567.443116197428, 8573.27127194183, 8576.528290944058, 5842.737076831638, 5912.911306330495, 5992.161097446448, 6095.634261944298, 6097.939020609737, 9699.175570076623, 10217.693469195936, 10354.637587684394, 10465.738356541147, 10470.685879423629, 10615.681529554126, 10638.787224255317, 10647.94676026615, 10655.30740501865, 10656.840147397641, 6962.686679099554, 7178.60517671533, 7424.183339832722, 7484.0, 7627.466077374531, 8577.785555361166, 8610.827783444422, 8713.0, 8713.43362681449, 8729.388942773945, 7652.617369131633, 7695.192004839411, 7712.730054448068, 7747.457677962489, 7825.139234684067, 7454.3663788576405, 7518.210587888193, 7531.623418828927, 7570.772876813704, 7572.3942084632, 7048.682809273492, 7092.148942126978, 7178.318059784312, 7183.102112235971, 7184.8922266165, 4992.400911890596, 5001.8749531260555, 5108.565771909281, 5169.53474187325, 5278.841634750964, 4351.0, 5124.692518448905, 5127.4103478099005, 5150.330457040711, 5221.0], "value": 4635.916129056527, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4895828133891, 299.7017967122712, 306.60907343137495, 312.4064277872043, 315.36611411063757, 5242.21366794981, 5429.429909859467, 5482.616216864821, 5525.723713814314, 5546.4730850569185, 4967.329410529586, 5171.844844654666, 5374.113271310229, 5381.81163659272, 5413.945860541394, 3685.2076803487244, 3881.9130643419817, 4183.518895327046, 4195.951012246938, 4213.810378532958, 3564.92870142597, 3580.9615211588607, 3852.383618621021, 3978.3435733104, 4201.634468797638, 3456.2914602506426, 4126.31915733905, 4193.475815523059, 4207.053412982085, 4223.070924396628, 3402.574678165229, 3529.541159649255, 4183.748975061506, 4205.537390887, 4235.597618226264, 3516.310022832535, 3572.7673952486352, 3620.330238905811, 3663.1757854482794, 3681.1901381695984, 4356.368326592658, 4625.907481850378, 5292.311999440087, 5361.935654772901, 5364.597655175839, 3810.428435734634, 4335.631471324909, 4874.8537543873745, 4890.266460031024, 4904.4605093439695, 4687.859364219079, 5590.0, 5663.405342439026, 5787.594868359217, 5793.681347525884, 3848.9230215395814, 4032.697547683906, 4035.6771458283265, 4048.9797551012352, 4081.4694489566414, 5004.774785134641, 5543.558674744595, 6015.699215039274, 6054.364291749347, 6083.695815209222, 3773.9432958771586, 3832.3676593362343, 3860.2472517858746, 4107.878012710302, 4165.604267594574, 3660.066682995819, 4203.831846726097, 4205.201011807808, 4211.778584210545, 4221.451211342506, 4389.736615803062, 4674.579287864109, 4915.90168196634, 4946.802127914915, 4949.307097006422, 4888.071266459361, 5203.713795741271, 5361.383440904268, 5889.617174883619, 5928.466438020599, 1217.5190799634095, 1344.2673742809995, 1382.7234553089422, 1384.9653758656113, 1429.121090529317, 791.6239786101555, 854.7008547008621, 863.3567991845989, 865.6450855149359, 870.9896520036854, 4271.572842715766, 4433.379326894237, 4579.038401935564, 4581.862544123682, 4597.609203217764, 4103.0663075900875, 4227.8097485613225, 4592.540745925381, 4880.291897835729, 4957.925631115536, 3771.528558930134, 3909.569947305794, 4222.4299719538085, 4556.521565235669, 4571.0, 2240.0959184693206, 2745.339069862744, 2844.4168945366564, 3106.2389714520086, 3137.733292670103, 5606.55147588192, 5867.618604790675, 5954.005408188305, 6189.257289125334, 6229.221347331583, 4707.741074240881, 5192.4807519248525, 6009.2188015557695, 6107.0, 6156.846078847975, 5551.777928882881, 6207.454943473154, 6214.550924237002, 6220.160278362454, 6227.283862355887, 4996.750162491933, 5958.910616340671, 5970.5223582114195, 5974.922914698846, 6003.219581454383, 5374.596905232202, 5411.458854114557, 5591.692456914909, 5661.377248502579, 5788.681622510802, 5152.793888244578, 6209.627422354673, 6212.440880320612, 6227.314995350417, 6229.750809967551, 3365.495175723661, 3912.7065470089287, 3916.6279203475624, 3950.656776695937, 3954.406838974177, 5597.832065038056, 5613.971930140323, 5733.684647344436, 6066.545009124245, 6066.908996364969, 5117.692938423706, 5698.8290351289525, 5719.2279042328755, 5847.26909136358, 5880.852978675567, 5851.71783004637, 5855.677937713466, 5881.647101173943, 5906.586538942232, 5913.645181289136, 4691.390119284471, 5240.659357141773, 5265.657732247391, 5552.278203833475, 5732.656040637575, 4712.905741885212, 5411.810586629449, 5820.576361964852, 5847.39790793093, 5882.470577648032, 5095.286659867547, 5672.808710170745, 5704.344000440003, 5708.743106560131, 5720.2849643794525], "value": 4110.4916057661685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.4023358860231, 800.3957012455595, 803.81512252182, 840.9032961209463, 870.577769781656, 15528.689426211484, 16082.83917160828, 16711.749323760152, 16843.578910527227, 17085.48743537696, 12313.569025084123, 15281.388744450209, 15297.923510382432, 15306.158161301124, 15311.23443827807, 720.5064530796395, 742.4802638153287, 903.3631289940593, 929.8279818233649, 930.7952250504912, 752.6725874244694, 752.9811754706121, 753.8266198774257, 754.6113751418025, 901.0358915959926, 987.0622908237203, 987.1855719031792, 989.1938070472578, 992.8510723391513, 994.4878387630376, 980.0493521284415, 983.3706427886159, 984.3503287830033, 986.9407835529819, 989.0, 729.8503806719609, 730.8209488675255, 733.2484203691206, 735.0995031086929, 736.4550232827722, 16477.505674829776, 16481.587960300967, 16620.750688739678, 16632.33470661172, 16650.0, 11771.823422648667, 13985.0, 14045.0, 14445.711085778226, 15562.0, 12913.418896149697, 13071.673208169777, 13095.0, 13566.253856037914, 13921.930390347983, 4646.465656449518, 4695.88260293492, 4713.269443236304, 4862.222044472903, 4876.609871210295, 126910.36544817218, 129527.35236323852, 131131.34434327862, 131621.0, 132186.33906830405, 11480.425978701032, 11789.0, 12135.817962730565, 12153.331566763913, 12196.878031219574, 19936.00319983995, 23006.309810705705, 23590.52818943646, 23776.405589860045, 23826.40433989164, 8232.917670823335, 8292.37807164465, 8338.708145214889, 8362.45644033136, 8575.614097365633, 4516.458025037016, 4617.445906491175, 4676.574075448747, 4797.56821886032, 4815.253635686474, 3511.2626348466597, 3655.049687081378, 3656.2687462507606, 3657.5062366580705, 3661.7802931824176, 697.6511744127936, 697.7627606613675, 698.4866123399297, 706.0221593093603, 709.2198581560242, 571.5227784799739, 654.0, 700.579652208681, 714.9204700901676, 719.1478098453244, 8396.706115285935, 9261.823471484196, 10001.49992500372, 10049.59801607942, 10248.0, 682.9453643708491, 691.1326285511651, 691.2327316678483, 697.7592730507967, 728.5956294256738, 3744.5506539215467, 4143.91712165755, 4849.466558678542, 4883.145449546315, 4990.451050384455, 97441.51279243559, 121053.0, 134974.62563435992, 160221.0, 164010.0, 112141.43929280301, 125780.37109814392, 128474.0, 131348.3432582831, 134175.0, 105061.36796949542, 118165.0, 120584.39707801405, 121933.0, 122188.77811221774, 9249.815003699754, 9512.38169518979, 9549.331546791936, 9565.713028609152, 9613.615455381987, 66599.0, 67152.66423667851, 67953.64092718216, 68675.62648746897, 68887.27781805495, 104206.0, 105387.0, 105529.944700552, 108241.0, 109052.0, 12253.69365765863, 12369.0, 12463.750724985268, 12676.619701408972, 12760.106792524433, 13462.798058028942, 13595.048346615642, 13595.320233988063, 13794.0, 13815.516456923959, 12152.966997805286, 12154.635360939186, 12505.499780009062, 13103.475860965455, 13225.537106201236, 11991.22057066288, 12657.493700252255, 12722.61832145037, 12732.809007865075, 13290.86709132935, 11906.642800715992, 12149.392530373623, 12153.210041347284, 12184.51261949512, 12255.32595707209, 10304.845427318447, 10395.32430392022, 10439.739006524898, 11203.327800332007, 11247.606333778278, 10869.29349592274, 10971.83542246851, 11110.833337500106, 11121.332720036824, 11161.330320180816], "value": 8108.613080365469, "unit": "score"}], "name": "dromaeo_css", "value": 7432.482383662412, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 106.0, 141.0, 110.0, 107.0, 106.0, 106.0, 163.0, 135.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 182.0, 182.0, 182.0, 183.0, 182.0, 182.0, 181.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 70.0, 102.0, 79.0, 83.0, 81.0, 67.0, 81.0, 56.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 94.0, 69.0, 68.0, 68.0, 93.0, 67.0, 67.0, 88.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 88.0, 89.0, 86.0, 91.0, 87.0, 89.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 98.0, 97.0, 97.0, 97.0, 97.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 84.0, 84.0, 83.0, 83.0, 84.0, 83.0, 84.0], "value": 83.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 52.0, 52.0, 55.0, 57.0, 55.0, 55.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 75.0, 74.0, 74.0, 69.0, 70.0, 71.0, 71.0, 72.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 83.0, 84.0, 81.0, 82.0, 83.0, 88.0, 99.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 130.0, 124.0, 156.0, 145.0, 145.0, 135.0, 141.0, 158.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 161.0, 162.0, 161.0, 160.0, 157.0, 160.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 66.0, 66.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1418.8000000000002, "alertThreshold": 2.0}]} 10:18:06 INFO - Return code: 0 10:18:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:06 INFO - # TBPL SUCCESS # 10:18:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:06 INFO - 2016-11-17 10:18:06.865 screenresolution[1654:9805] starting screenresolution argv=screenresolution get 10:18:06 INFO - 2016-11-17 10:18:06.869 screenresolution[1654:9805] Display 0: 1600x1200x32@60 10:18:06 INFO - 2016-11-17 10:18:06.875 screenresolution[1655:9808] starting screenresolution argv=screenresolution list 10:18:06 INFO - Available Modes on Display 0 10:18:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:07 INFO - Intel Iris: 10:18:07 INFO - Chipset Model: Intel Iris 10:18:07 INFO - Type: GPU 10:18:07 INFO - Bus: Built-In 10:18:07 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:07 INFO - Vendor: Intel (0x8086) 10:18:07 INFO - Device ID: 0x0a2e 10:18:07 INFO - Revision ID: 0x0009 10:18:07 INFO - Displays: 10:18:07 INFO - Display: 10:18:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:07 INFO - Display Serial Number: 1600x1200 60 10:18:07 INFO - Main Display: Yes 10:18:07 INFO - Mirror: Off 10:18:07 INFO - Online: Yes 10:18:07 INFO - Rotation: Supported 10:18:07 INFO - Return code: 0 10:18:07 INFO - Running post-action listener: _resource_record_post_action 10:18:07 INFO - [mozharness: 2016-11-17 18:18:07.111127Z] Finished run-tests step (success) 10:18:07 INFO - Running post-run listener: _resource_record_post_run 10:18:07 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38454272; Write bytes: 492495872; Read time: 380; Write time: 1858 10:18:07 INFO - TinderboxPrint: CPU usage
53.4% 10:18:07 INFO - TinderboxPrint: I/O read bytes / time
38,454,272 / 380 10:18:07 INFO - TinderboxPrint: I/O write bytes / time
492,495,872 / 1,858 10:18:07 INFO - TinderboxPrint: CPU idle
2,229.4 (46.6%) 10:18:07 INFO - TinderboxPrint: CPU system
960.3 (20.1%) 10:18:07 INFO - TinderboxPrint: CPU user
1,592.0 (33.3%) 10:18:07 INFO - TinderboxPrint: Swap in / out
233,635,840 / 0 10:18:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190265856; Write bytes: 185724928; Read time: 17599; Write time: 338 10:18:07 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36504576; Write bytes: 295744512; Read time: 360; Write time: 1485 10:18:07 INFO - Running post-run listener: _upload_blobber_files 10:18:07 INFO - Blob upload gear active. 10:18:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:07 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 10:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:18:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:09 INFO - (blobuploader) - INFO - Done attempting. 10:18:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:10 INFO - (blobuploader) - INFO - Done attempting. 10:18:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:12 INFO - (blobuploader) - INFO - Done attempting. 10:18:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:12 INFO - Return code: 0 10:18:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4abed26c931de83f47e49189c15fb3fe8effca8bbfa8fc67f2d610ada47194263bb736b87313d14c588b6e65176ba837bf2b9234433c94e517c539ce4bd89a08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce5e98ea59dad2be4ba4b59087ad3541c9f1bed1243b4b1907a16452f9a54b7bf59b3df29c61f4470950150777e7ef8cfa5e6c0dfc38c26b98ac7b3e7a7aad02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d91ae39679454d8f269a2ffd50206d97f1d0849baccf50c95793c9190900beb45ac0461175c87a6629e775338257d40c5367e786eff9f04da67eba618280848"} 10:18:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:12 INFO - Contents: 10:18:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4abed26c931de83f47e49189c15fb3fe8effca8bbfa8fc67f2d610ada47194263bb736b87313d14c588b6e65176ba837bf2b9234433c94e517c539ce4bd89a08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce5e98ea59dad2be4ba4b59087ad3541c9f1bed1243b4b1907a16452f9a54b7bf59b3df29c61f4470950150777e7ef8cfa5e6c0dfc38c26b98ac7b3e7a7aad02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d91ae39679454d8f269a2ffd50206d97f1d0849baccf50c95793c9190900beb45ac0461175c87a6629e775338257d40c5367e786eff9f04da67eba618280848"} 10:18:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:12 INFO - Copying logs to upload dir... 10:18:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.883827 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-17 10:18:12.556928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 10:18:12.560632) ========= 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.qFdqefeqpT/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.78suuS5RHX/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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-Beta/sha512/4abed26c931de83f47e49189c15fb3fe8effca8bbfa8fc67f2d610ada47194263bb736b87313d14c588b6e65176ba837bf2b9234433c94e517c539ce4bd89a08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce5e98ea59dad2be4ba4b59087ad3541c9f1bed1243b4b1907a16452f9a54b7bf59b3df29c61f4470950150777e7ef8cfa5e6c0dfc38c26b98ac7b3e7a7aad02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d91ae39679454d8f269a2ffd50206d97f1d0849baccf50c95793c9190900beb45ac0461175c87a6629e775338257d40c5367e786eff9f04da67eba618280848"} build_url:https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010573 build_url: 'https://queue.taskcluster.net/v1/task/XMF7j6LOQO64cr-tVj07Nw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4abed26c931de83f47e49189c15fb3fe8effca8bbfa8fc67f2d610ada47194263bb736b87313d14c588b6e65176ba837bf2b9234433c94e517c539ce4bd89a08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce5e98ea59dad2be4ba4b59087ad3541c9f1bed1243b4b1907a16452f9a54b7bf59b3df29c61f4470950150777e7ef8cfa5e6c0dfc38c26b98ac7b3e7a7aad02", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d91ae39679454d8f269a2ffd50206d97f1d0849baccf50c95793c9190900beb45ac0461175c87a6629e775338257d40c5367e786eff9f04da67eba618280848"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 10:18:12.593253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:18:12.593654) ========= 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.qFdqefeqpT/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.78suuS5RHX/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.005124 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:18:12.644161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 10:18:12.644530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 10:18:12.644916) ========= ========= Total master_lag: 0.19 =========