builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0289 starttime: 1484260009.41 results: success (0) buildid: 20170112121116 builduid: c18004c46d7d46ba840c365d7e71b0bb revision: 31ebd0e871c54c2e212d2fcc30adaf986bcae367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.412632) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.413145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.413501) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.440725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.441148) ========= 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.ANthf4ax6O/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.jqSH6mK8KB/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 --2017-01-12 14:26:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 30.2M=0s 2017-01-12 14:26:49 (30.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153439 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.619028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.619394) ========= 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.ANthf4ax6O/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.jqSH6mK8KB/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.025913 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:49.667871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 14:26:49.668223) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 31ebd0e871c54c2e212d2fcc30adaf986bcae367 --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 31ebd0e871c54c2e212d2fcc30adaf986bcae367 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ANthf4ax6O/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.jqSH6mK8KB/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 2017-01-12 14:26:49,769 truncating revision to first 12 chars 2017-01-12 14:26:49,769 Setting DEBUG logging. 2017-01-12 14:26:49,769 attempt 1/10 2017-01-12 14:26:49,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/31ebd0e871c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 14:26:50,464 unpacking tar archive at: mozilla-beta-31ebd0e871c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.164029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 14:26:50.855779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:50.856228) ========= script_repo_revision: 31ebd0e871c54c2e212d2fcc30adaf986bcae367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:50.856654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:50.856951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 14:26:50.878731) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-12 14:26:50.879355) ========= /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.ANthf4ax6O/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.jqSH6mK8KB/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:26:51 INFO - MultiFileLogger online at 20170112 14:26:51 in /builds/slave/test 14:26:51 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 14:26:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:26:51 INFO - {'append_to_log': False, 14:26:51 INFO - 'base_work_dir': '/builds/slave/test', 14:26:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:26:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:26:51 INFO - 'branch': 'Mozilla-Beta', 14:26:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:26:51 INFO - 'config_files': ('talos/mac_config.py',), 14:26:51 INFO - 'default_actions': ('clobber', 14:26:51 INFO - 'read-buildbot-config', 14:26:51 INFO - 'download-and-extract', 14:26:51 INFO - 'populate-webroot', 14:26:51 INFO - 'create-virtualenv', 14:26:51 INFO - 'install', 14:26:51 INFO - 'run-tests'), 14:26:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:26:51 INFO - 'download_minidump_stackwalk': True, 14:26:51 INFO - 'download_symbols': 'ondemand', 14:26:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:26:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:26:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:26:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:26:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:26:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:26:51 INFO - 'installer_path': 'installer.exe', 14:26:51 INFO - 'log_level': 'info', 14:26:51 INFO - 'log_name': 'talos', 14:26:51 INFO - 'log_to_console': True, 14:26:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:26:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:26:51 INFO - 'opt_config_files': (), 14:26:51 INFO - 'pip_index': False, 14:26:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:51 INFO - 'cmd': ('bash', 14:26:51 INFO - '-c', 14:26:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:51 INFO - 'enabled': True, 14:26:51 INFO - 'halt_on_failure': False, 14:26:51 INFO - 'name': 'check_screen_resolution'},), 14:26:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:51 INFO - 'cmd': ('bash', 14:26:51 INFO - '-c', 14:26:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:51 INFO - 'enabled': True, 14:26:51 INFO - 'halt_on_failure': False, 14:26:51 INFO - 'name': 'check_screen_resolution'},), 14:26:51 INFO - 'run_cmd_checks_enabled': True, 14:26:51 INFO - 'sps_profile': False, 14:26:51 INFO - 'sps_profile_interval': 0, 14:26:51 INFO - 'suite': 'dromaeojs', 14:26:51 INFO - 'system_bits': '32', 14:26:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:26:51 INFO - 'title': 't-yosemite-r7-0289', 14:26:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:26:51 INFO - 'use_talos_json': True, 14:26:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:26:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:26:51 INFO - 'work_dir': 'build'} 14:26:51 INFO - [mozharness: 2017-01-12 22:26:51.082938Z] Running clobber step. 14:26:51 INFO - Running pre-action listener: _resource_record_pre_action 14:26:51 INFO - Running main action method: clobber 14:26:51 INFO - rmtree: /builds/slave/test/build 14:26:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:26:53 INFO - Running post-action listener: _resource_record_post_action 14:26:53 INFO - [mozharness: 2017-01-12 22:26:53.555519Z] Finished clobber step (success) 14:26:53 INFO - [mozharness: 2017-01-12 22:26:53.555662Z] Running read-buildbot-config step. 14:26:53 INFO - Running pre-action listener: _resource_record_pre_action 14:26:53 INFO - Running main action method: read_buildbot_config 14:26:53 INFO - Using buildbot properties: 14:26:53 INFO - { 14:26:53 INFO - "project": "", 14:26:53 INFO - "product": "firefox", 14:26:53 INFO - "script_repo_revision": "production", 14:26:53 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:26:53 INFO - "repository": "", 14:26:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:26:53 INFO - "buildid": "20170112121116", 14:26:53 INFO - "pgo_build": "False", 14:26:53 INFO - "basedir": "/builds/slave/test", 14:26:53 INFO - "buildnumber": 19, 14:26:53 INFO - "slavename": "t-yosemite-r7-0289", 14:26:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:26:53 INFO - "platform": "yosemite_r7", 14:26:53 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:26:53 INFO - "branch": "mozilla-beta", 14:26:53 INFO - "repo_path": "releases/mozilla-beta", 14:26:53 INFO - "revision": "31ebd0e871c54c2e212d2fcc30adaf986bcae367", 14:26:53 INFO - "stage_platform": "macosx64", 14:26:53 INFO - "builduid": "c18004c46d7d46ba840c365d7e71b0bb", 14:26:53 INFO - "slavebuilddir": "test" 14:26:53 INFO - } 14:26:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 14:26:53 INFO - Running post-action listener: _resource_record_post_action 14:26:53 INFO - [mozharness: 2017-01-12 22:26:53.558991Z] Finished read-buildbot-config step (success) 14:26:53 INFO - [mozharness: 2017-01-12 22:26:53.559120Z] Running download-and-extract step. 14:26:53 INFO - Running pre-action listener: _resource_record_pre_action 14:26:53 INFO - Running main action method: download_and_extract 14:26:53 INFO - mkdir: /builds/slave/test/build/tests 14:26:53 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')]} 14:26:53 INFO - trying https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 14:26:53 INFO - Downloading https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/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 14:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/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 14:26:54 INFO - Downloaded 1165 bytes. 14:26:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:26:54 INFO - Using the following test package requirements: 14:26:54 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:26:54 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 14:26:54 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 14:26:54 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:26:54 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 14:26:54 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:26:54 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 14:26:54 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 14:26:54 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 14:26:54 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:26:54 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 14:26:54 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 14:26:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:26:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:26:54 INFO - Fetch https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:26:55 INFO - Expected file size: 16236156 14:27:01 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 14:27:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:27:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:27:01 INFO - Fetch https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:27:02 INFO - Expected file size: 16236156 14:27:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 14:27:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 14:27:09 INFO - Fetch https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 14:27:10 INFO - Expected file size: 14414089 14:27: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')]} 14:27:10 INFO - trying https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:27:10 INFO - Downloading https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 14:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/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 14:27:12 INFO - Downloaded 86178216 bytes. 14:27:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:27:12 INFO - mkdir: /builds/slave/test/properties 14:27:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:12 INFO - Contents: 14:27:12 INFO - build_url:https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:27:13 INFO - Running post-action listener: _resource_record_post_action 14:27:13 INFO - Running post-action listener: set_extra_try_arguments 14:27:13 INFO - [mozharness: 2017-01-12 22:27:13.602957Z] Finished download-and-extract step (success) 14:27:13 INFO - [mozharness: 2017-01-12 22:27:13.603102Z] Running populate-webroot step. 14:27:13 INFO - Running pre-action listener: _resource_record_pre_action 14:27:13 INFO - Running main action method: populate_webroot 14:27:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:13 INFO - '--tppagecycles', 14:27:13 INFO - '7'], 14:27:13 INFO - 'tests': ['tsvgm']}}, 14:27:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['damp', 'tps']}, 14:27:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'tests': ['damp', 'tps']}, 14:27:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['dromaeo_dom']}, 14:27:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['basic_compositor_video']}, 14:27:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:27:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['a11yr', 14:27:13 INFO - 'ts_paint', 14:27:13 INFO - 'tpaint', 14:27:13 INFO - 'sessionrestore', 14:27:13 INFO - 'sessionrestore_no_auto_restore', 14:27:13 INFO - 'tabpaint']}, 14:27:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:13 INFO - 'ts_paint', 14:27:13 INFO - 'tpaint', 14:27:13 INFO - 'sessionrestore', 14:27:13 INFO - 'sessionrestore_no_auto_restore', 14:27:13 INFO - 'tabpaint']}, 14:27:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:13 INFO - 'ts_paint', 14:27:13 INFO - 'tpaint', 14:27:13 INFO - 'sessionrestore', 14:27:13 INFO - 'sessionrestore_no_auto_restore', 14:27:13 INFO - 'tabpaint']}, 14:27:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:13 INFO - 'ts_paint', 14:27:13 INFO - 'tpaint', 14:27:13 INFO - 'sessionrestore', 14:27:13 INFO - 'sessionrestore_no_auto_restore', 14:27:13 INFO - 'tabpaint']}, 14:27:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['a11yr', 14:27:13 INFO - 'ts_paint', 14:27:13 INFO - 'tpaint', 14:27:13 INFO - 'sessionrestore', 14:27:13 INFO - 'sessionrestore_no_auto_restore', 14:27:13 INFO - 'tabpaint']}, 14:27:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['a11yr', 14:27:13 INFO - 'ts_paint', 14:27:13 INFO - 'tpaint', 14:27:13 INFO - 'sessionrestore', 14:27:13 INFO - 'sessionrestore_no_auto_restore', 14:27:13 INFO - 'tabpaint']}, 14:27:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['tsvgx', 14:27:13 INFO - 'tsvgr_opacity', 14:27:13 INFO - 'tart', 14:27:13 INFO - 'tscrollx', 14:27:13 INFO - 'cart']}, 14:27:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:13 INFO - 'tsvgr_opacity', 14:27:13 INFO - 'tart', 14:27:13 INFO - 'tscrollx', 14:27:13 INFO - 'cart']}, 14:27:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'talos_options': ['--disable-e10s'], 14:27:13 INFO - 'tests': ['tp5o']}, 14:27:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'tests': ['tp5o']}, 14:27:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'talos_options': ['--disable-e10s', 14:27:13 INFO - '--xperf_path', 14:27:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:13 INFO - 'tests': ['tp5n']}, 14:27:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:13 INFO - 'talos_options': ['--xperf_path', 14:27:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:13 INFO - 'tests': ['tp5n']}}, 14:27:13 INFO - 'talos.zip': {'path': '', 14:27:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:13 INFO - Running post-action listener: _resource_record_post_action 14:27:13 INFO - [mozharness: 2017-01-12 22:27:13.622160Z] Finished populate-webroot step (success) 14:27:13 INFO - [mozharness: 2017-01-12 22:27:13.622295Z] Running create-virtualenv step. 14:27:13 INFO - Running pre-action listener: _resource_record_pre_action 14:27:13 INFO - Running main action method: create_virtualenv 14:27:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:27:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:13 INFO - Using real prefix '/tools/python27' 14:27:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:17 INFO - Installing pip.................done. 14:27:17 INFO - Return code: 0 14:27:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:17 INFO - 'HOME': '/Users/cltbld', 14:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:17 INFO - 'LOGNAME': 'cltbld', 14:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:17 INFO - 'MOZ_NO_REMOTE': '1', 14:27:17 INFO - 'NO_EM_RESTART': '1', 14:27:17 INFO - 'PAGER': '/bin/cat', 14:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:17 INFO - 'PWD': '/builds/slave/test', 14:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:17 INFO - 'SHELL': '/bin/bash', 14:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:17 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:17 INFO - 'USER': 'cltbld', 14:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:17 INFO - 'XPC_FLAGS': '0x0', 14:27:17 INFO - 'XPC_SERVICE_NAME': '0', 14:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:27:17 INFO - Cleaning up... 14:27:17 INFO - Return code: 0 14:27:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:17 INFO - 'HOME': '/Users/cltbld', 14:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:17 INFO - 'LOGNAME': 'cltbld', 14:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:17 INFO - 'MOZ_NO_REMOTE': '1', 14:27:17 INFO - 'NO_EM_RESTART': '1', 14:27:17 INFO - 'PAGER': '/bin/cat', 14:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:17 INFO - 'PWD': '/builds/slave/test', 14:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:17 INFO - 'SHELL': '/bin/bash', 14:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:17 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:17 INFO - 'USER': 'cltbld', 14:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:17 INFO - 'XPC_FLAGS': '0x0', 14:27:17 INFO - 'XPC_SERVICE_NAME': '0', 14:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:17 INFO - Downloading/unpacking psutil>=3.1.1 14:27:17 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 14:27:17 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 14:27:17 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 14:27:17 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 14:27:17 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 14:27:17 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 14:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:21 INFO - Installing collected packages: psutil 14:27:21 INFO - Running setup.py install for psutil 14:27:21 INFO - building 'psutil._psutil_osx' extension 14:27:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:27:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:27:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:27:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:27:21 INFO - building 'psutil._psutil_posix' extension 14:27:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:27:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:27:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:27:22 INFO - ^ 14:27:22 INFO - 1 warning generated. 14:27:22 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 14:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:22 INFO - Successfully installed psutil 14:27:22 INFO - Cleaning up... 14:27:22 INFO - Return code: 0 14:27:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:22 INFO - 'HOME': '/Users/cltbld', 14:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:22 INFO - 'LOGNAME': 'cltbld', 14:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:22 INFO - 'MOZ_NO_REMOTE': '1', 14:27:22 INFO - 'NO_EM_RESTART': '1', 14:27:22 INFO - 'PAGER': '/bin/cat', 14:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:22 INFO - 'PWD': '/builds/slave/test', 14:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:22 INFO - 'SHELL': '/bin/bash', 14:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:22 INFO - 'USER': 'cltbld', 14:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:22 INFO - 'XPC_FLAGS': '0x0', 14:27:22 INFO - 'XPC_SERVICE_NAME': '0', 14:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:27:25 INFO - Installing collected packages: mozsystemmonitor 14:27:25 INFO - Running setup.py install for mozsystemmonitor 14:27:25 INFO - Successfully installed mozsystemmonitor 14:27:25 INFO - Cleaning up... 14:27:25 INFO - Return code: 0 14:27:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:25 INFO - 'HOME': '/Users/cltbld', 14:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:25 INFO - 'LOGNAME': 'cltbld', 14:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:25 INFO - 'MOZ_NO_REMOTE': '1', 14:27:25 INFO - 'NO_EM_RESTART': '1', 14:27:25 INFO - 'PAGER': '/bin/cat', 14:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:25 INFO - 'PWD': '/builds/slave/test', 14:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:25 INFO - 'SHELL': '/bin/bash', 14:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:25 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:25 INFO - 'USER': 'cltbld', 14:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:25 INFO - 'XPC_FLAGS': '0x0', 14:27:25 INFO - 'XPC_SERVICE_NAME': '0', 14:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:29 INFO - warning: no files found matching '*.txt' 14:27:29 INFO - no previously-included directories found matching 'build' 14:27:29 INFO - no previously-included directories found matching 'dist' 14:27:29 INFO - no previously-included directories found matching '.git*' 14:27:29 INFO - Installing collected packages: jsonschema, functools32 14:27:29 INFO - Running setup.py install for functools32 14:27:29 INFO - warning: no files found matching '*.txt' 14:27:29 INFO - no previously-included directories found matching 'build' 14:27:29 INFO - no previously-included directories found matching 'dist' 14:27:29 INFO - no previously-included directories found matching '.git*' 14:27:29 INFO - Successfully installed jsonschema functools32 14:27:29 INFO - Cleaning up... 14:27:29 INFO - Return code: 0 14:27:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:29 INFO - 'HOME': '/Users/cltbld', 14:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:29 INFO - 'LOGNAME': 'cltbld', 14:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:29 INFO - 'MOZ_NO_REMOTE': '1', 14:27:29 INFO - 'NO_EM_RESTART': '1', 14:27:29 INFO - 'PAGER': '/bin/cat', 14:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:29 INFO - 'PWD': '/builds/slave/test', 14:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:29 INFO - 'SHELL': '/bin/bash', 14:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:29 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:29 INFO - 'USER': 'cltbld', 14:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:29 INFO - 'XPC_FLAGS': '0x0', 14:27:29 INFO - 'XPC_SERVICE_NAME': '0', 14:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:27:29 INFO - Cleaning up... 14:27:29 INFO - Return code: 0 14:27:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:29 INFO - 'HOME': '/Users/cltbld', 14:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:29 INFO - 'LOGNAME': 'cltbld', 14:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:29 INFO - 'MOZ_NO_REMOTE': '1', 14:27:29 INFO - 'NO_EM_RESTART': '1', 14:27:29 INFO - 'PAGER': '/bin/cat', 14:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:29 INFO - 'PWD': '/builds/slave/test', 14:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:29 INFO - 'SHELL': '/bin/bash', 14:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:29 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:29 INFO - 'USER': 'cltbld', 14:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:29 INFO - 'XPC_FLAGS': '0x0', 14:27:29 INFO - 'XPC_SERVICE_NAME': '0', 14:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:27:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:27:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:27:33 INFO - Downloading docopt-0.6.1.tar.gz 14:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:27:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:27:33 INFO - Running setup.py install for blobuploader 14:27:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:27:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:27:34 INFO - Running setup.py install for requests 14:27:34 INFO - Running setup.py install for docopt 14:27:34 INFO - Successfully installed blobuploader requests docopt 14:27:34 INFO - Cleaning up... 14:27:34 INFO - Return code: 0 14:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:34 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')]} 14:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:34 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')]} 14:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:34 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 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:34 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 14:27:34 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 14:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:34 INFO - 'HOME': '/Users/cltbld', 14:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:34 INFO - 'LOGNAME': 'cltbld', 14:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:34 INFO - 'MOZ_NO_REMOTE': '1', 14:27:34 INFO - 'NO_EM_RESTART': '1', 14:27:34 INFO - 'PAGER': '/bin/cat', 14:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:34 INFO - 'PWD': '/builds/slave/test', 14:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:34 INFO - 'SHELL': '/bin/bash', 14:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:34 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:34 INFO - 'USER': 'cltbld', 14:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:34 INFO - 'XPC_FLAGS': '0x0', 14:27:34 INFO - 'XPC_SERVICE_NAME': '0', 14:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-MnSE3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jBMUAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-bsLE4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-T7vue4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-liUGEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-imxdaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-FV5OvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-DLA5Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-8YQ33g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:35 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-psYGxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-K_mOQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-So35Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-7ybx9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-cX9nLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-pMfZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-5GnF15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-5jkUQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:27:36 INFO - Running setup.py install for manifestparser 14:27:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:27:36 INFO - Running setup.py install for mozcrash 14:27:36 INFO - Running setup.py install for mozdebug 14:27:37 INFO - Running setup.py install for mozdevice 14:27:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Running setup.py install for mozfile 14:27:37 INFO - Running setup.py install for mozhttpd 14:27:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Running setup.py install for mozinfo 14:27:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Running setup.py install for mozInstall 14:27:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:27:37 INFO - Running setup.py install for mozleak 14:27:38 INFO - Running setup.py install for mozlog 14:27:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:27:38 INFO - Running setup.py install for moznetwork 14:27:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:27:38 INFO - Running setup.py install for mozprocess 14:27:38 INFO - Running setup.py install for mozprofile 14:27:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:27:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:27:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:27:38 INFO - Running setup.py install for mozrunner 14:27:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:27:38 INFO - Running setup.py install for mozscreenshot 14:27:38 INFO - Running setup.py install for moztest 14:27:39 INFO - Running setup.py install for mozversion 14:27:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:27:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:27:39 INFO - Cleaning up... 14:27:39 INFO - Return code: 0 14:27:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:39 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')]} 14:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:39 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')]} 14:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:39 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 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:39 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 14:27:39 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 14:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:39 INFO - 'HOME': '/Users/cltbld', 14:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:39 INFO - 'LOGNAME': 'cltbld', 14:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:39 INFO - 'MOZ_NO_REMOTE': '1', 14:27:39 INFO - 'NO_EM_RESTART': '1', 14:27:39 INFO - 'PAGER': '/bin/cat', 14:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:39 INFO - 'PWD': '/builds/slave/test', 14:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:39 INFO - 'SHELL': '/bin/bash', 14:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:39 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:39 INFO - 'USER': 'cltbld', 14:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:39 INFO - 'XPC_FLAGS': '0x0', 14:27:39 INFO - 'XPC_SERVICE_NAME': '0', 14:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:39 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-PQMizx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:39 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)) 14:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:39 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-c81kTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:39 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)) 14:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:39 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-a999Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:39 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-KkXSNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:39 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-dGkIG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-St6BCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-OS0Xv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-pIEnce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-v4Uaou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Lh2j5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ARMpFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:40 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)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-MEjsy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-06I3nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-yeqgDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:41 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)) 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vtgbXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:41 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)) 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-6ToXg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:41 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)) 14:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-LQWRuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:41 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)) 14:27:41 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)) 14:27:41 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)) 14:27:41 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)) 14:27:41 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)) 14:27:41 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)) 14:27:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:41 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 14:27:41 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 14:27:41 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 14:27:41 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 14:27:41 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 14:27:41 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 14:27:44 INFO - Downloading blessings-1.6.tar.gz 14:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:44 INFO - Installing collected packages: blessings 14:27:44 INFO - Running setup.py install for blessings 14:27:44 INFO - Successfully installed blessings 14:27:44 INFO - Cleaning up... 14:27:44 INFO - Return code: 0 14:27:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:44 INFO - Reading from file tmpfile_stdout 14:27:44 INFO - Current package versions: 14:27:44 INFO - blessings == 1.6 14:27:44 INFO - blobuploader == 1.2.4 14:27:44 INFO - docopt == 0.6.1 14:27:44 INFO - functools32 == 3.2.3-2 14:27:44 INFO - jsonschema == 2.5.1 14:27:44 INFO - manifestparser == 1.1 14:27:44 INFO - mozInstall == 1.12 14:27:44 INFO - mozcrash == 0.17 14:27:44 INFO - mozdebug == 0.1 14:27:44 INFO - mozdevice == 0.48 14:27:44 INFO - mozfile == 1.2 14:27:44 INFO - mozhttpd == 0.7 14:27:44 INFO - mozinfo == 0.9 14:27:44 INFO - mozleak == 0.1 14:27:44 INFO - mozlog == 3.4 14:27:44 INFO - moznetwork == 0.27 14:27:44 INFO - mozprocess == 0.23 14:27:44 INFO - mozprofile == 0.28 14:27:44 INFO - mozrunner == 6.12 14:27:44 INFO - mozscreenshot == 0.1 14:27:44 INFO - mozsystemmonitor == 0.3 14:27:44 INFO - moztest == 0.7 14:27:44 INFO - mozversion == 1.4 14:27:44 INFO - psutil == 3.1.1 14:27:44 INFO - requests == 1.2.3 14:27:44 INFO - wsgiref == 0.1.2 14:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:45 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')]} 14:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:45 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 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:45 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 14:27:45 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 14:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:45 INFO - 'HOME': '/Users/cltbld', 14:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:45 INFO - 'LOGNAME': 'cltbld', 14:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:45 INFO - 'MOZ_NO_REMOTE': '1', 14:27:45 INFO - 'NO_EM_RESTART': '1', 14:27:45 INFO - 'PAGER': '/bin/cat', 14:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:45 INFO - 'PWD': '/builds/slave/test', 14:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:45 INFO - 'SHELL': '/bin/bash', 14:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:45 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:45 INFO - 'USER': 'cltbld', 14:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:45 INFO - 'XPC_FLAGS': '0x0', 14:27:45 INFO - 'XPC_SERVICE_NAME': '0', 14:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 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)) 14:27:45 INFO - Cleaning up... 14:27:45 INFO - Return code: 0 14:27:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27:45 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')]} 14:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:45 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')]} 14:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:45 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 0x10ab8d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8799cefe20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, '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.ANthf4ax6O/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.jqSH6mK8KB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 14:27:45 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 14:27:45 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 14:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:45 INFO - 'HOME': '/Users/cltbld', 14:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:45 INFO - 'LOGNAME': 'cltbld', 14:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:45 INFO - 'MOZ_NO_REMOTE': '1', 14:27:45 INFO - 'NO_EM_RESTART': '1', 14:27:45 INFO - 'PAGER': '/bin/cat', 14:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:45 INFO - 'PWD': '/builds/slave/test', 14:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:45 INFO - 'SHELL': '/bin/bash', 14:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:27:45 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:45 INFO - 'USER': 'cltbld', 14:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:45 INFO - 'XPC_FLAGS': '0x0', 14:27:45 INFO - 'XPC_SERVICE_NAME': '0', 14:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:27:45 INFO - Cleaning up... 14:27:45 INFO - Return code: 0 14:27:45 INFO - Running post-action listener: _resource_record_post_action 14:27:45 INFO - Running post-action listener: _start_resource_monitoring 14:27:45 INFO - Starting resource monitoring. 14:27:45 INFO - [mozharness: 2017-01-12 22:27:45.591185Z] Finished create-virtualenv step (success) 14:27:45 INFO - [mozharness: 2017-01-12 22:27:45.592127Z] Running install step. 14:27:45 INFO - Running pre-action listener: _resource_record_pre_action 14:27:45 INFO - Running main action method: install 14:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:45 INFO - Reading from file tmpfile_stdout 14:27:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:45 INFO - Reading from file tmpfile_stdout 14:27:45 INFO - Output received: 14:27:45 INFO - Usage: mozinstall [options] installer 14:27:45 INFO - Options: 14:27:45 INFO - -h, --help show this help message and exit 14:27:45 INFO - -d DEST, --destination=DEST 14:27:45 INFO - Directory to install application into. [default: 14:27:45 INFO - "/builds/slave/test"] 14:27:45 INFO - --app=APP Application being installed. [default: firefox] 14:27:45 INFO - mkdir: /builds/slave/test/build/application 14:27:45 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'] 14:27:45 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 14:28:07 INFO - Reading from file tmpfile_stdout 14:28:07 INFO - Output received: 14:28:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:28:07 INFO - Running post-action listener: _resource_record_post_action 14:28:07 INFO - [mozharness: 2017-01-12 22:28:07.499528Z] Finished install step (success) 14:28:07 INFO - [mozharness: 2017-01-12 22:28:07.499678Z] Running run-tests step. 14:28:07 INFO - Running pre-action listener: _resource_record_pre_action 14:28:07 INFO - Running main action method: run_tests 14:28:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:28:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:28:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:28:07 INFO - 2017-01-12 14:28:07.513 screenresolution[1615:7494] starting screenresolution argv=screenresolution get 14:28:07 INFO - 2017-01-12 14:28:07.516 screenresolution[1615:7494] Display 0: 1600x1200x32@60 14:28:07 INFO - 2017-01-12 14:28:07.522 screenresolution[1616:7497] starting screenresolution argv=screenresolution list 14:28:07 INFO - Available Modes on Display 0 14:28:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:28:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:28:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:28:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:07 INFO - Intel Iris: 14:28:07 INFO - Chipset Model: Intel Iris 14:28:07 INFO - Type: GPU 14:28:07 INFO - Bus: Built-In 14:28:07 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:07 INFO - Vendor: Intel (0x8086) 14:28:07 INFO - Device ID: 0x0a2e 14:28:07 INFO - Revision ID: 0x0009 14:28:07 INFO - Displays: 14:28:07 INFO - Display: 14:28:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:07 INFO - Display Serial Number: 1600x1200 60 14:28:07 INFO - Main Display: Yes 14:28:07 INFO - Mirror: Off 14:28:07 INFO - Online: Yes 14:28:07 INFO - Rotation: Supported 14:28:07 INFO - Return code: 0 14:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:07 INFO - Python 2.7.3 14:28:07 INFO - Return code: 0 14:28:07 INFO - grabbing minidump binary from tooltool 14:28:07 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')]} 14:28:07 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 0x10a9a1d30>, '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 0x10a807db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a999b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:07 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 14:28:07 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 14:28:07 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 14:28:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:07 INFO - Return code: 0 14:28:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:28:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:28:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:07 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/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 14:28:07 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/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0289 --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 14:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ANthf4ax6O/Render', 14:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:07 INFO - 'HOME': '/Users/cltbld', 14:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:07 INFO - 'LOGNAME': 'cltbld', 14:28:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:07 INFO - 'MOZ_NO_REMOTE': '1', 14:28:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:07 INFO - 'NO_EM_RESTART': '1', 14:28:07 INFO - 'PAGER': '/bin/cat', 14:28:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:07 INFO - 'PWD': '/builds/slave/test', 14:28:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:07 INFO - 'SHELL': '/bin/bash', 14:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqSH6mK8KB/Listeners', 14:28:07 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 14:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:07 INFO - 'USER': 'cltbld', 14:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:07 INFO - 'XPC_FLAGS': '0x0', 14:28:07 INFO - 'XPC_SERVICE_NAME': '0', 14:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:07 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/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 14:28:08 INFO - mozversion application_buildid: 20170112121116 14:28:08 INFO - mozversion application_changeset: 31ebd0e871c54c2e212d2fcc30adaf986bcae367 14:28:08 INFO - mozversion application_display_name: Firefox 14:28:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:08 INFO - mozversion application_name: Firefox 14:28:08 INFO - mozversion application_remotingname: firefox 14:28:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:28:08 INFO - mozversion application_vendor: Mozilla 14:28:08 INFO - mozversion application_version: 51.0 14:28:08 INFO - mozversion platform_buildid: 20170112121116 14:28:08 INFO - mozversion platform_changeset: 31ebd0e871c54c2e212d2fcc30adaf986bcae367 14:28:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:28:08 INFO - mozversion platform_version: 51.0 14:28:08 INFO - using testdate: 1484260088 14:28:08 INFO - actual date: 1484260088 14:28:08 INFO - starting webserver on 'localhost:49235' 14:28:08 INFO - SUITE-START | Running 2 tests 14:28:08 INFO - TEST-START | dromaeo_css 14:28:08 INFO - operating with platform_type : mac_ 14:28:08 INFO - Initialising browser for dromaeo_css test... 14:28:08 INFO - TEST-INFO | started process 1626 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpaSzPrO/profile http://localhost:49235/getInfo.html) 14:28:10 INFO - PROCESS | 1626 | __metrics Screen width/height:1600/1200 14:28:10 INFO - PROCESS | 1626 | colorDepth:24 14:28:10 INFO - PROCESS | 1626 | Browser inner width/height: 1024/689 14:28:10 INFO - PROCESS | 1626 | __metrics 14:28:10 INFO - PROCESS | 1626 | 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" 14:28:10 INFO - PROCESS | 1626 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:11 INFO - TEST-INFO | 1626: exit 0 14:28:11 INFO - Browser initialized. 14:28:11 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:11 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpaSzPrO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:23 INFO - PROCESS | 1629 | RSS: Main: 168681472 14:28:23 INFO - PROCESS | 1629 | 14:29:14 INFO - PROCESS | 1629 | 1484260154551 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] 14:31:24 INFO - PROCESS | 1629 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 14:31:26 INFO - PROCESS | 1629 | RSS: Main: 336883712 14:31:26 INFO - PROCESS | 1629 | 14:34:29 INFO - PROCESS | 1629 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 14:34:30 INFO - PROCESS | 1629 | RSS: Main: 301096960 14:34:30 INFO - PROCESS | 1629 | 14:37:32 INFO - PROCESS | 1629 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 14:37:32 INFO - PROCESS | 1629 | RSS: Main: 299134976 14:37:32 INFO - PROCESS | 1629 | 14:40:34 INFO - PROCESS | 1629 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 14:40:35 INFO - PROCESS | 1629 | RSS: Main: 266715136 14:40:35 INFO - PROCESS | 1629 | 14:43:38 INFO - PROCESS | 1629 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 14:43:39 INFO - PROCESS | 1629 | RSS: Main: 261853184 14:43:39 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 14:46:42 INFO - PROCESS | 1629 | RSS: Main: 514850816 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | __start_tp_report 14:46:42 INFO - PROCESS | 1629 | _x_x_mozilla_page_load 14:46:42 INFO - PROCESS | 1629 | _x_x_mozilla_page_load_details 14:46:42 INFO - PROCESS | 1629 | |i|pagename|runs| 14:46:42 INFO - PROCESS | 1629 | |0;dojo.html;3451.2407270400504;3475.47867819827;3490.2495963367887;3502.8440614597152;3552.8756493522715;5652.208690783294;5664.915026274609;5719.313682358113;5721.199032135494;5748.942510574898;5663.8584035399135;5736.569757268201;5743.994800909845;5757.68332741699;5759.020966435705;5148.871278218037;5167.974160129213;5203.86990325243;5217.191335343028;5217.191335343028;5125.948740512603;5141.4087379951225;5156.819511317105;5278.788848446057;5280.471952804727;5178.585713142939;5207.817726379578;5209.114450543417;5215.478452154774;5221.582273418117;5205;5226.033183860979;5270.051390749663;5273.683578985273;5317.202419637086;5080.085584594772;5131;5208.348956380452;5230.058589453897;5240.082985477527;4071.6335529802163;5602.355729091166;5617.4382561743905;5636.15457681347;5711.514521265697;6177.289611694623;6177.320494745574;6193.814185574395;6254.499640028786;6294.055891616248;5243.659162154448;6283.439156346621;6337.112804207414;6344.841378965517;6354.237491501003;5670.149477578355;5691.68695721731;5738.569607279387;5741.712914354265;5804.419558044204;6290.811275661646;6315.431611154926;6331.841703957438;6333.334999825044;6340.112384266206;6155.384461553898;6159.1069294951985;6161.507079433634;6167.938320616737;6172.22847144107;6129.14485165794;6197.318294987548;6228.22147231596;6284.277308109535;6316.147320111726;6140.6929653517145;6146.78486252979;6168.19813424252;6207.410296021871;6211.409916057967;6199.473044791243;6217.96891015542;6232.906506402408;6233.719482623293;6249.7187626556915;4439.711418757835;4712.246040633482;4725.842168668698;4913;4958.702477851269;3901.882943511699;4500.932486012713;4518.661100417482;4526.683132180716;4538.863834084983;5708.771649134072;5719.656820590694;5731.426857314235;5738.397468265855;5750.827475175752;6141.486007784275;6192.195014648157;6211.782587609502;6218.751249949952;6236.875262494725;5768.3654797972185;5811.796587119515;5812.215350927655;5831.7667293307795;5852.917210316105;5410.702411367334;5423.159410291411;5426.728663566806;5430.456954304538;5444.074507333763;6217.347178546188;6248.156498872594;6267.561270711098;6276.309605943343;6308.116863639002;5171.3018742469285;6223.3465486125115;6264.968675156595;6272.466840318624;6284.340144284967;6298.748050077946;6302.180716506825;6307.24313082433;6338.11266422692;6342.968285158545;6246.125542424155;6249.375062493896;6252.562320637512;6263.342349053284;6267.905981410374;6165.784197553244;6203.379662033761;6331.651759153291;6341.682915854281;6343.841403964938;6095.847603809941;6104.847378815565;6112.938870611415;6157.291911430243;6176.258848938156;5980.611260268069;6101.884493623382;6121.785737499166;6158.876822463615;6162.599431036968;5808.303003639421;6011.87976240464;6027.487663548647;6027.57806953509;6041.697915104315;6007.8197654070445;6010.759569617341;6031.60794548353;6109.419605137505;6140.938590614037;5991.161237426677;5993;5996.670183139795;6002.759889604542;6018.458338749533 14:46:42 INFO - PROCESS | 1629 | |1;ext.html;493.9110960027195;503.7758247458676;519.1771042897008;520.8828013696916;538.647186093109;29915.401691966148;32617.18457038575;34356.79751208708;34435.31129377411;34531;35703.285934281295;45272.54727452724;46045.07909841801;46093.76953115238;48143.75928120363;10088.991100889907;10264.178865690765;10268;10276.280660353777;10284.331518451314;9922.702318930407;9961.302708810386;10078.244131690117;10088.192944564416;10092.646757363495;9406.388584742004;9698.418094914292;12323.383830808469;12538.874611253908;12575.622731318075;12371.948384387293;12516.31160286193;12517.561885334015;12535.498580056787;12580.559680411234;12480.75038499234;12516.436760345807;12524.499020039279;12533.874661253361;12554.058445616523;42757.786211069055;42981.14037719228;42982.785086074684;42996.14007719828;43120.56879431197;3713.286713286713;3713.294474049922;4121.175764847043;4122.196171746511;4211.97894010531;32020.839895800604;32083.679163208304;32454;32960.17599560006;33028.83485582557;3359.8656053757823;3371.0561042908025;3429;3431.897043088711;3479.1650003998857;518377.408112957;520570;520985;521318;521384.3930780322;62762;63235.6838215806;63273.683631581545;63303.36696632975;63305.36694633087;35821.31340149499;36276.911692649264;36485.45271820925;36490.8175459121;37686.62313376886;17692.557686057953;17876.106194690212;17955;17955.820441795677;17955.910220448815;13306.534271300457;13427.925765938702;13446.529371472147;13455.394507247198;13466.528671496451;17620.94274343518;19758.901205494167;19874.403767886986;20246.291379801638;20286.594268114553;7249.565026098346;7582.090149182023;8515.531645759544;8552.828943421096;8593.269572086443;853.4196746212511;970.7233438470003;988.6836212412103;1087.505185140759;1139.2537887683582;31931;32017.839910800296;32025.839870800963;32286.677133228837;32785.83607081997;1110.3337997201777;1112.5494174859195;1149;1185.199990006742;1194.331174542259;16401.015939043697;16524.4216452426;16546.007239565664;16583.6683266334;16988.06565638902;706923;715071;716856;717437;720485;53988;54494;54546.454535454934;56913.43086569164;61632.691836541424;1221.2916508425092;1305.2690493323769;1411.1815147214795;1413.8656827601362;1437.367558274356;31068.689313107483;32866.50700239546;33061.504077438374;33119.337613248084;33606;52218;52815.207771882684;52841;52909.47090529199;52912.941741165734;554085;555889;556226;557967;803387;24577.50844983126;24815.87592062028;24883.253502394957;24886.626700599143;45989.310160348294;48246.27630585614;48724.26913596228;52590.211146832065;52943.20585191302;53200;41683.58316416797;43283;43494;43718;44683.329750053126;41975.53085641988;42319.5768042328;43158.13683726245;43660.56339436565;44340.778296108314;41590.58409415867;42260;42449.78775106105;42556;43065.569344306154;32352;34908.60365585348;35511.82244088763;37099.0320774332;37781.43327850029;27331;27339.86330068337;27354;27362;27841.721582784725 14:46:42 INFO - PROCESS | 1629 | |2;jquery.html;387.1366851920218;388.6210944329281;389.3303517949127;396.60141557734465;418.481083456514;14345;16279;21069.05189266483;21856.45358866029;21880.890595547018;20957.685634715453;21061.789382106173;21816.90915454229;21930.903454827276;22103.889480552614;5890.381509941448;6248.531360147985;6250.812475625738;6255.62466252024;6260.968695156541;3456.9110730120055;6107.786227482039;6169.845753856167;6212.192414986068;6230.439260466557;6215.782447614334;6235.719392627343;6241;6245.937540624604;6253.1245625612455;6019.5485338599565;6070.150178974947;6146.231721034871;6153.292371377304;6169.290531588835;4594.287885377772;5150.484951504857;5356.9732151339385;5372.247885296023;5374.193870919355;26449.603255951177;26882.46235075307;27075.864620676966;27218.591721124;27394.904203831822;2300.0346689118846;2413.3604594782396;2487.639292302606;3071.66211716711;3077.79965813333;15840.128792916385;15862.762058569131;15958.281877315549;16077.598060048475;16738.74891876623;1933.4006457998066;1978.5251539630528;1997.7502812148482;2012.5572374077678;2040.8877511736848;118385.81614183834;120954;123112.38443807814;123684;125904.11143832942;10930.398828064373;10992.395418251914;11429.542818287342;11505.712357191138;11715.765684686428;12856.421461034275;13601.979851510978;14337.139771613736;14370.065945713495;14408.639784005483;8541.743747687578;8800.559972001374;8898.510581918057;8938.68714594986;9050.411723237969;7507.324340809353;9029.77425564353;9079.954600226956;9092.909070909338;9116.36185467011;5623.381428042912;6733.360330768569;6808.8978665320055;6842.6578671066245;6857.417119544894;1807.9186436610385;1918.9904050479938;1922.7884932657396;1928.9421317360502;1929.2668785861283;764.3273918951287;890.528020149322;919.9862002069974;948.83869742144;963.7253382785873;16304;16700.58248543796;22571;22632;23028;861.9525926074001;990.4948476277151;999.8400255959011;1022.8005538919839;1044.9007344302279;11212.27120237182;12258.81611775824;12387.318697471726;12482.75034499305;12525.185862918881;619368;621078;631093.8445307744;642327;642415;116265.41867290779;122639;123996.38001809933;129086.70913290935;129967.35016324857;862.4264863865459;949.6533765175661;1013.9746506337401;1053.4995876958537;1054.3199636234585;19806.702899456806;20062.49843753918;20563.69154462714;20658.17367305291;20671.06980185865;43751.56248437475;45127;47841;53581.464185359204;58587;73450;85927;86775.56612216898;87453.1254687445;88516;6886;8064.475809072626;8145.674173033012;8513.40406171562;8610.364030834122;12200.328981905725;13199.538016169772;13605.591832245049;13706.794398083837;13707.314634268047;11229.88770112321;11854.585089521825;11982.041436685218;11997.460114294703;12073.456694448947;11370.090392768725;11373.715657108638;11453.828192577284;11736.119791015537;12004.639860804189;11394.25937314072;11558.595449159238;11784.646460606196;12163.75672486563;12200.206986545845;6902.482313826383;8156.306713929145;8182.263596276363;8609.354298427768;8612.741617751477;9517.381370210915;11525.366104864313;11610.825837612612;11628.360440175871;11888.643340699793 14:46:42 INFO - PROCESS | 1629 | |3;mootools.html;1470.794088827564;1529.6787674588336;1750.7461418094376;1817.4456790678855;1933.39098184072;8580.313574914007;9151.95424022879;9164.037776033512;9166.81666366674;9217.354785165033;7930.801729956754;8169.959150204256;8674;8834.60244289007;8862.867056994133;2343.2970108967284;2376.7979721723586;2380.2740164249985;2382.4163080045414;2384.284714585617;2071.1508281604547;2315.270689732729;2363.5745565798147;2378.9643155352596;2396.1613435297595;1970.48767320497;2359.775821296974;2373.8931748071377;2385.6997936124767;2402.159244264511;2328.697269354973;2342.824288178385;2351.4356554426986;2353.7528559501347;2378.2389635316704;2366.0062773635113;2382.4639456122236;2385.4155731845635;2387.1167667962964;2388.0686532252435;9065.048169942127;9151.496667683276;9154.31342649304;9164.358494905358;9174.220191283683;5279.023380674587;5393.892122157574;5468.507834294933;5480.6437581557075;5570.387257401682;3508.947365789515;3596.37063513884;3673.834677439522;3681.44778283257;3682.4844521766972;1051.3113910388709;1067.3969207397795;1074.0601973273385;1077.7682798198425;1092.415557676647;12065.155439119266;12084.758304833855;12108.636740897788;12124.696882578006;12139;4657.790399432034;4662.557057079572;4843.588294994895;4848.296996935495;4920.114379411741;10237.385756854612;10248.948755256177;10256.692299231036;10265.12746416563;10271.075603195599;5515.972420137874;5516.779328826802;5520.309961254843;5523.944760552424;5528.281323428009;4577.862664120082;4729.621630269639;4902;5004.699718016931;5060.962502686941;4008.518977722692;4045.7572545647354;4098.877033688994;4133.9793301033305;4165.354370072643;1306.3859985806655;1313.3367649337024;1317.8616245294297;1321.8347706536683;1325.4830616059744;860.0367588301143;891.6166048599165;915.2357781252729;920.4845286639503;948.5209968965628;5786.826395208066;5964.373740757158;6014.488768454643;6082.178905847654;6119.990201616683;384.7691385168876;427.46993727777954;446.1990726645679;446.2436170690713;446.26366495282394;3674.2651469706166;3674.3202507536193;3709.870154544632;3750.8124593770203;3789.0716774390453;10455.738606534898;10989.340639561651;11006.449677516091;11016.834747478793;11053.392063436588;10930.070943969693;10947.726306842233;10953.83569246462;10977.83533246986;11013.83479247812;8217.260446559838;8260.421770476129;8423.410361274775;8437.451565648336;8448.662053518035;5578.442155784389;5618.494335509824;5723.656580605177;5803.651780892991;5834.18321434991;9997.650082247086;10031.347962382422;10129.442880641636;10250.821155567206;10273.02406271403;10244.846327304947;10394.116500097576;10489.737756556147;10522.31604945676;10609.045185933302;6946.409555187865;7322.340989310987;7579.5073320234005;7708.306252437307;7817.765467035998;8638.26574741154;8717.52053637056;8718.694845680371;8720.561107417205;8726.869096963677;7574.772756817304;7642.082950045808;7682.385409167141;7829.060512738508;7842.882356764767;7467.962660186664;7505.699772009277;7564.357029652321;7568.924310756822;7681.846363072819;7010.859782804213;7138.286171382821;7151.499395042297;7155.642217889189;7156.1770396403;4901.09329773993;4933.77797999098;4939.43196532389;4972.129877271391;4979.153543897619;4932.4327702314695;5015.974920125376;5045.142325804695;5130.358705161855;5142.614303927296 14:46:42 INFO - PROCESS | 1629 | |4;prototype.html;306.85577778444133;308.7499125708175;315.2261198757052;320.5256220793226;323.6714734544436;5345.866353341164;5448.863778405537;5454.481824226702;5460.863478413042;5465.9726701366535;4663.790129444174;4769.713817170964;5052.014857102867;5148.485151484859;5436.320459942507;3139.544766008927;3838.558565764945;4011.83952641894;4017;4039.555648878621;3188.984055079721;4023.4769479967563;4077.979610101945;4099.749576379203;4123.60825721556;3954.8022598870084;4051.534073581546;4075.3683179107284;4079.4288799568085;4103.548609652936;3387.3225354929114;3421.230223199785;4092.754434733911;4095.1809638072505;4105.58944105587;2993.2938225211637;3170.7780455368134;3191.760617953663;3311.586051743532;3562.8040457774814;4383.956160438419;5130.460422091089;5139.792148845018;5200.92198617021;5256.842294731126;4427.645788336926;4581.908361832745;4597.839075632337;4604.145429833491;4646.744429056401;4772.284157376422;5194.22086687;5501.5420913457965;5521.889562208774;5559.305086864142;3274.918127046819;3942.7437216581116;3954.2486927483687;3986.740861843971;4006.7996600169877;5407.945920540784;5833.57077516007;5842.474177324061;5847.649141051551;5867.823965281048;3091.4280858041334;3233.644299127094;3749.868754593631;3872.786996715208;3886.620249811333;3610.476480910306;3666.651668091527;3947.2105578883766;3949.328614135604;3971.900702482403;4055.8986025349604;4245.384419259251;4571.805533344013;4647.279671650899;4657.650676199299;4629.328747331618;4661.720296782204;5289.709066001406;5292.338457692788;5560.833175004756;1199.7840388729937;1242.931638759877;1288.7229245712028;1312.6455856918578;1327.5154568582398;853.4111463090447;882.5631312500353;882.6381183714647;935.3265648732902;966.4539535162611;4386.363977223348;4902.965269413154;5218.295530103387;5228.477152284741;5245.606579506552;5626.071698169838;5645.491905728422;5663.348714897757;5719.8570035749435;5783.94216057834;4180.770057646859;5273.683578985273;5343.251944727741;5388.572028412474;5407.215953686693;2809.9578506322423;2994.82031078136;3026.72759451646;3032.150997720642;3042.0721679887406;4866.975665121722;5735.719387270931;6010.459058684652;6066.969665151646;6131.63210207389;5021.397432308147;5111.412187598399;5690.130711116398;5846.4153584642045;5933.970330148408;5184.766685499086;5407.70257635826;5924.51887028243;5959.344472108065;5967.6419414835245;4529.6602754794185;4846.975765121152;5477.616566840283;5741.1388291756575;5825.475707186373;5711.971440142773;5729.169270455677;5751.424857514216;5763.077907534775;5767.904098221325;5746.511546518593;5993.190919225849;6010.368911264429;6070;6242.157308763259;3901.96098039016;3902.434147048719;3929.8821035368983;3975.157762200041;3986.063275130284;5071.5656484888195;5135.460776618401;5901;5952.76188952437;5966.313873904556;4334.45819272591;5268.57851371897;5480.91778623313;5776.884462310646;5854.326752423526;5188.22176673502;5648.5481161507805;5651;5720.542356611544;5747.758374234136;5282.47175282484;5540.307461567304;5578.721063946705;5586.273784408164;5610.298712660918;5076.619253555924;5139.511746384088;5163.66436181647;5611.298587676541;5633.549316054788;4583.9312410313205;5546.58400619947;5548.69482178484;5569.303837020372;5618.39875635442 14:46:42 INFO - PROCESS | 1629 | |5;yui.html;610.8320211941716;719.5898337947369;821.5194111444805;845.826605545863;861.272224969901;16296.18519074046;17050.74423883641;17055.573610659725;17090.401835935743;17126.914365428154;15252.161131137784;15342.923285383586;15358.923205383957;15364.462243821468;15370.846291537082;725.6625669063884;738.726671131682;884.995575022124;897.833900728364;910.4491782471608;914.8399030169694;917.6742256498947;920.2729843423688;924.7179610218881;925.0379605210607;984.2175470500933;985.2019863910256;986.1075726467558;987.3039507147444;989.3964681544252;983.9655612053543;985.418603024212;985.6303886042734;985.7190700650316;989.4310771306527;736.6169591812228;737.4874462248739;739.6819367671899;741.1735914455397;743.6021728375347;15583.922080389526;15587.766183507256;15598.220088995506;15655.13896735679;15663.530094097081;13586.660333491644;13673.974451916147;14028.298585070706;14050.227237501933;14053.08654937436;13023.348832558335;13056.151350162305;13353.465861365534;13599;14049.5082672107;4829.251466022772;4862.5380588844;4967.975160124212;5000.949990500085;5025.221090730943;128264.0760388595;131323;132025.6797432023;132118;132959.33520332433;8992.775180620536;11047.613333533287;11599.304041757352;11640.650780476599;11655.242409243372;21320.253791117546;21871.453213669785;21930;21954.560908781736;22046.228382006553;7894.64474098667;7993.32056775169;8079.232472915063;8378.036525799489;8430.765847050536;3837.9808100959317;4540.228161212602;4713.080949214938;4796.112719146969;4822.855314340575;2987.3129180288656;3534.4874993125854;3605.6574625410544;3646.5441819772527;3652.908677283089;560.7028275014248;660.5310229736845;666.7832954289876;675.8445557521798;678.7420780103529;545.3319683387818;588.805694120939;617.5368473644767;626.5932980458899;645.2805122288709;9047.638094476148;9368.34421590482;9448.385854919408;9511.857322140173;9609.423434593808;630.6562923206864;633.8383712153463;651.3356376495948;652.5823472977298;675.9594424334457;4282.678799090081;4604.7927843247135;4642.117997580449;4653.348061438141;4709.599684026827;124911;162275.829312802;163470;163517.18241408718;175528.12235938737;119490;119743;121071;124898;132056;107453.38819917708;115812;116498;118792;124777.37611312067;9934.552945117342;10430.634927777492;10536;10590.682279531626;10628.468576570986;53110;61604.383956159865;62304.376956229855;62822;63369.09892703226;95929.5203523978;98066.65970325892;101267.49366253417;103063.4846825761;104383.4780826091;13454.730905382034;13543.525976590772;13755.31223438804;13791.862081379459;14132.646683832987;14763.778543321643;15328.386864525293;15430.84569154339;15844.207789610704;16677.332906683598;12904.41930113166;13214.307099658445;14086.01397902137;14419.567412977207;14739.410423582936;13876.791848122488;13916.791248131489;14712.485063022743;14857;15323.846761532242;13572.1856688599;13892.93053534726;14676.41294348214;14902.180380078766;15111.924440377728;11580.710482238012;11749.177557571229;11838.526458941546;11918;12019.519219231133;10611.41637209961;10934.890651093387;11912.463939122934;11954.222975506564;12138.211016283913 14:46:42 INFO - PROCESS | 1629 | __end_tp_report 14:46:42 INFO - PROCESS | 1629 | __start_cc_report 14:46:42 INFO - PROCESS | 1629 | _x_x_mozilla_cycle_collect,1626 14:46:42 INFO - PROCESS | 1629 | __end_cc_report 14:46:42 INFO - PROCESS | 1629 | __startTimestamp1484261202517__endTimestamp 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | ------- Summary: start ------- 14:46:42 INFO - PROCESS | 1629 | Number of tests: 6 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | [#0] dojo.html Cycles:165 Average:5734.00 Median:6002.76 stddev:652.97 (10.9%) stddev-sans-first:629.94 14:46:42 INFO - PROCESS | 1629 | Values: 3451.2 3475.5 3490.2 3502.8 3552.9 5652.2 5664.9 5719.3 5721.2 5748.9 5663.9 5736.6 5744.0 5757.7 5759.0 5148.9 5168.0 5203.9 5217.2 5217.2 5125.9 5141.4 5156.8 5278.8 5280.5 5178.6 5207.8 5209.1 5215.5 5221.6 5205.0 5226.0 5270.1 5273.7 5317.2 5080.1 5131.0 5208.3 5230.1 5240.1 4071.6 5602.4 5617.4 5636.2 5711.5 6177.3 6177.3 6193.8 6254.5 6294.1 5243.7 6283.4 6337.1 6344.8 6354.2 5670.1 5691.7 5738.6 5741.7 5804.4 6290.8 6315.4 6331.8 6333.3 6340.1 6155.4 6159.1 6161.5 6167.9 6172.2 6129.1 6197.3 6228.2 6284.3 6316.1 6140.7 6146.8 6168.2 6207.4 6211.4 6199.5 6218.0 6232.9 6233.7 6249.7 4439.7 4712.2 4725.8 4913.0 4958.7 3901.9 4500.9 4518.7 4526.7 4538.9 5708.8 5719.7 5731.4 5738.4 5750.8 6141.5 6192.2 6211.8 6218.8 6236.9 5768.4 5811.8 5812.2 5831.8 5852.9 5410.7 5423.2 5426.7 5430.5 5444.1 6217.3 6248.2 6267.6 6276.3 6308.1 5171.3 6223.3 6265.0 6272.5 6284.3 6298.7 6302.2 6307.2 6338.1 6343.0 6246.1 6249.4 6252.6 6263.3 6267.9 6165.8 6203.4 6331.7 6341.7 6343.8 6095.8 6104.8 6112.9 6157.3 6176.3 5980.6 6101.9 6121.8 6158.9 6162.6 5808.3 6011.9 6027.5 6027.6 6041.7 6007.8 6010.8 6031.6 6109.4 6140.9 5991.2 5993.0 5996.7 6002.8 6018.5 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | [#1] ext.html Cycles:180 Average:74544.94 Median:35762.30 stddev:166416.84 (465.3%) stddev-sans-first:166790.81 14:46:42 INFO - PROCESS | 1629 | Values: 493.9 503.8 519.2 520.9 538.6 29915.4 32617.2 34356.8 34435.3 34531.0 35703.3 45272.5 46045.1 46093.8 48143.8 10089.0 10264.2 10268.0 10276.3 10284.3 9922.7 9961.3 10078.2 10088.2 10092.6 9406.4 9698.4 12323.4 12538.9 12575.6 12371.9 12516.3 12517.6 12535.5 12580.6 12480.8 12516.4 12524.5 12533.9 12554.1 42757.8 42981.1 42982.8 42996.1 43120.6 3713.3 3713.3 4121.2 4122.2 4212.0 32020.8 32083.7 32454.0 32960.2 33028.8 3359.9 3371.1 3429.0 3431.9 3479.2 518377.4 520570.0 520985.0 521318.0 521384.4 62762.0 63235.7 63273.7 63303.4 63305.4 35821.3 36276.9 36485.5 36490.8 37686.6 17692.6 17876.1 17955.0 17955.8 17955.9 13306.5 13427.9 13446.5 13455.4 13466.5 17620.9 19758.9 19874.4 20246.3 20286.6 7249.6 7582.1 8515.5 8552.8 8593.3 853.4 970.7 988.7 1087.5 1139.3 31931.0 32017.8 32025.8 32286.7 32785.8 1110.3 1112.5 1149.0 1185.2 1194.3 16401.0 16524.4 16546.0 16583.7 16988.1 706923.0 715071.0 716856.0 717437.0 720485.0 53988.0 54494.0 54546.5 56913.4 61632.7 1221.3 1305.3 1411.2 1413.9 1437.4 31068.7 32866.5 33061.5 33119.3 33606.0 52218.0 52815.2 52841.0 52909.5 52912.9 554085.0 555889.0 556226.0 557967.0 803387.0 24577.5 24815.9 24883.3 24886.6 45989.3 48246.3 48724.3 52590.2 52943.2 53200.0 41683.6 43283.0 43494.0 43718.0 44683.3 41975.5 42319.6 43158.1 43660.6 44340.8 41590.6 42260.0 42449.8 42556.0 43065.6 32352.0 34908.6 35511.8 37099.0 37781.4 27331.0 27339.9 27354.0 27362.0 27841.7 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | [#2] jquery.html Cycles:180 Average:36479.43 Median:2450.50 stddev:105067.58 (4287.6%) stddev-sans-first:105327.37 14:46:42 INFO - PROCESS | 1629 | Values: 387.1 388.6 389.3 396.6 418.5 14345.0 16279.0 21069.1 21856.5 21880.9 20957.7 21061.8 21816.9 21930.9 22103.9 5890.4 6248.5 6250.8 6255.6 6261.0 3456.9 6107.8 6169.8 6212.2 6230.4 6215.8 6235.7 6241.0 6245.9 6253.1 6019.5 6070.2 6146.2 6153.3 6169.3 4594.3 5150.5 5357.0 5372.2 5374.2 26449.6 26882.5 27075.9 27218.6 27394.9 2300.0 2413.4 2487.6 3071.7 3077.8 15840.1 15862.8 15958.3 16077.6 16738.7 1933.4 1978.5 1997.8 2012.6 2040.9 118385.8 120954.0 123112.4 123684.0 125904.1 10930.4 10992.4 11429.5 11505.7 11715.8 12856.4 13602.0 14337.1 14370.1 14408.6 8541.7 8800.6 8898.5 8938.7 9050.4 7507.3 9029.8 9080.0 9092.9 9116.4 5623.4 6733.4 6808.9 6842.7 6857.4 1807.9 1919.0 1922.8 1928.9 1929.3 764.3 890.5 920.0 948.8 963.7 16304.0 16700.6 22571.0 22632.0 23028.0 862.0 990.5 999.8 1022.8 1044.9 11212.3 12258.8 12387.3 12482.8 12525.2 619368.0 621078.0 631093.8 642327.0 642415.0 116265.4 122639.0 123996.4 129086.7 129967.4 862.4 949.7 1014.0 1053.5 1054.3 19806.7 20062.5 20563.7 20658.2 20671.1 43751.6 45127.0 47841.0 53581.5 58587.0 73450.0 85927.0 86775.6 87453.1 88516.0 6886.0 8064.5 8145.7 8513.4 8610.4 12200.3 13199.5 13605.6 13706.8 13707.3 11229.9 11854.6 11982.0 11997.5 12073.5 11370.1 11373.7 11453.8 11736.1 12004.6 11394.3 11558.6 11784.6 12163.8 12200.2 6902.5 8156.3 8182.3 8609.4 8612.7 9517.4 11525.4 11610.8 11628.4 11888.6 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | [#3] mootools.html Cycles:180 Average:5814.50 Median:4660.17 stddev:3325.49 (71.4%) stddev-sans-first:3318.80 14:46:42 INFO - PROCESS | 1629 | Values: 1470.8 1529.7 1750.7 1817.4 1933.4 8580.3 9152.0 9164.0 9166.8 9217.4 7930.8 8170.0 8674.0 8834.6 8862.9 2343.3 2376.8 2380.3 2382.4 2384.3 2071.2 2315.3 2363.6 2379.0 2396.2 1970.5 2359.8 2373.9 2385.7 2402.2 2328.7 2342.8 2351.4 2353.8 2378.2 2366.0 2382.5 2385.4 2387.1 2388.1 9065.0 9151.5 9154.3 9164.4 9174.2 5279.0 5393.9 5468.5 5480.6 5570.4 3508.9 3596.4 3673.8 3681.4 3682.5 1051.3 1067.4 1074.1 1077.8 1092.4 12065.2 12084.8 12108.6 12124.7 12139.0 4657.8 4662.6 4843.6 4848.3 4920.1 10237.4 10248.9 10256.7 10265.1 10271.1 5516.0 5516.8 5520.3 5523.9 5528.3 4577.9 4729.6 4902.0 5004.7 5061.0 4008.5 4045.8 4098.9 4134.0 4165.4 1306.4 1313.3 1317.9 1321.8 1325.5 860.0 891.6 915.2 920.5 948.5 5786.8 5964.4 6014.5 6082.2 6120.0 384.8 427.5 446.2 446.2 446.3 3674.3 3674.3 3709.9 3750.8 3789.1 10455.7 10989.3 11006.4 11016.8 11053.4 10930.1 10947.7 10953.8 10977.8 11013.8 8217.3 8260.4 8423.4 8437.5 8448.7 5578.4 5618.5 5723.7 5803.7 5834.2 9997.7 10031.3 10129.4 10250.8 10273.0 10244.8 10394.1 10489.7 10522.3 10609.0 6946.4 7322.3 7579.5 7708.3 7817.8 8638.3 8717.5 8718.7 8720.6 8726.9 7574.8 7642.1 7682.4 7829.1 7842.9 7468.0 7505.7 7564.4 7568.9 7681.8 7010.9 7138.3 7151.5 7155.6 7156.2 4901.1 4933.8 4939.4 4972.1 4979.2 4932.4 5016.0 5045.1 5130.4 5142.6 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | [#4] prototype.html Cycles:180 Average:4518.98 Median:5137.49 stddev:1412.37 (27.5%) stddev-sans-first:1380.49 14:46:42 INFO - PROCESS | 1629 | Values: 306.9 308.7 315.2 320.5 323.7 5345.9 5448.9 5454.5 5460.9 5466.0 4663.8 4769.7 5052.0 5148.5 5436.3 3139.5 3838.6 4011.8 4017.0 4039.6 3189.0 4023.5 4078.0 4099.7 4123.6 3954.8 4051.5 4075.4 4079.4 4103.5 3387.3 3421.2 4092.8 4095.2 4105.6 2993.3 3170.8 3191.8 3311.6 3562.8 4384.0 5130.5 5139.8 5200.9 5256.8 4427.6 4581.9 4597.8 4604.1 4646.7 4772.3 5194.2 5501.5 5521.9 5559.3 3274.9 3942.7 3954.2 3986.7 4006.8 5407.9 5833.6 5842.5 5847.6 5867.8 3091.4 3233.6 3749.9 3872.8 3886.6 3610.5 3666.7 3947.2 3949.3 3971.9 4055.9 4245.4 4571.8 4647.3 4657.7 4629.3 4661.7 5289.7 5292.3 5560.8 1199.8 1242.9 1288.7 1312.6 1327.5 853.4 882.6 882.6 935.3 966.5 4386.4 4903.0 5218.3 5228.5 5245.6 5626.1 5645.5 5663.3 5719.9 5783.9 4180.8 5273.7 5343.3 5388.6 5407.2 2810.0 2994.8 3026.7 3032.2 3042.1 4867.0 5735.7 6010.5 6067.0 6131.6 5021.4 5111.4 5690.1 5846.4 5934.0 5184.8 5407.7 5924.5 5959.3 5967.6 4529.7 4847.0 5477.6 5741.1 5825.5 5712.0 5729.2 5751.4 5763.1 5767.9 5746.5 5993.2 6010.4 6070.0 6242.2 3902.0 3902.4 3929.9 3975.2 3986.1 5071.6 5135.5 5901.0 5952.8 5966.3 4334.5 5268.6 5480.9 5776.9 5854.3 5188.2 5648.5 5651.0 5720.5 5747.8 5282.5 5540.3 5578.7 5586.3 5610.3 5076.6 5139.5 5163.7 5611.3 5633.5 4583.9 5546.6 5548.7 5569.3 5618.4 14:46:42 INFO - PROCESS | 1629 | 14:46:42 INFO - PROCESS | 1629 | [#5] yui.html Cycles:180 Average:26298.37 Median:98424.19 stddev:42186.81 (42.9%) stddev-sans-first:42261.07 14:46:42 INFO - PROCESS | 1629 | Values: 610.8 719.6 821.5 845.8 861.3 16296.2 17050.7 17055.6 17090.4 17126.9 15252.2 15342.9 15358.9 15364.5 15370.8 725.7 738.7 885.0 897.8 910.4 914.8 917.7 920.3 924.7 925.0 984.2 985.2 986.1 987.3 989.4 984.0 985.4 985.6 985.7 989.4 736.6 737.5 739.7 741.2 743.6 15583.9 15587.8 15598.2 15655.1 15663.5 13586.7 13674.0 14028.3 14050.2 14053.1 13023.3 13056.2 13353.5 13599.0 14049.5 4829.3 4862.5 4968.0 5000.9 5025.2 128264.1 131323.0 132025.7 132118.0 132959.3 8992.8 11047.6 11599.3 11640.7 11655.2 21320.3 21871.5 21930.0 21954.6 22046.2 7894.6 7993.3 8079.2 8378.0 8430.8 3838.0 4540.2 4713.1 4796.1 4822.9 2987.3 3534.5 3605.7 3646.5 3652.9 560.7 660.5 666.8 675.8 678.7 545.3 588.8 617.5 626.6 645.3 9047.6 9368.3 9448.4 9511.9 9609.4 630.7 633.8 651.3 652.6 676.0 4282.7 4604.8 4642.1 4653.3 4709.6 124911.0 162275.8 163470.0 163517.2 175528.1 119490.0 119743.0 121071.0 124898.0 132056.0 107453.4 115812.0 116498.0 118792.0 124777.4 9934.6 10430.6 10536.0 10590.7 10628.5 53110.0 61604.4 62304.4 62822.0 63369.1 95929.5 98066.7 101267.5 103063.5 104383.5 13454.7 13543.5 13755.3 13791.9 14132.6 14763.8 15328.4 15430.8 15844.2 16677.3 12904.4 13214.3 14086.0 14419.6 14739.4 13876.8 13916.8 14712.5 14857.0 15323.8 13572.2 13892.9 14676.4 14902.2 15111.9 11580.7 11749.2 11838.5 11918.0 12019.5 10611.4 10934.9 11912.5 11954.2 12138.2 14:46:42 INFO - PROCESS | 1629 | -------- Summary: end -------- 14:46:42 INFO - PROCESS | 1629 | 14:46:43 INFO - TEST-INFO | 1629: exit 0 14:46:43 INFO - TEST-OK | dromaeo_css | took 1114962ms 14:46:43 INFO - TEST-START | kraken 14:46:43 INFO - operating with platform_type : mac_ 14:46:43 INFO - Initialising browser for kraken test... 14:46:43 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpCbgp9M/profile http://localhost:49235/getInfo.html) 14:46:45 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 14:46:45 INFO - PROCESS | 1641 | colorDepth:24 14:46:45 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 14:46:45 INFO - PROCESS | 1641 | __metrics 14:46:45 INFO - PROCESS | 1641 | 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" 14:46:45 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:46:45 INFO - TEST-INFO | 1641: exit 0 14:46:45 INFO - Browser initialized. 14:46:45 INFO - Running cycle 1/1 for kraken test... 14:46:45 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpCbgp9M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:57 INFO - PROCESS | 1643 | RSS: Main: 169295872 14:46:57 INFO - PROCESS | 1643 | 14:47:00 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:01 INFO - PROCESS | 1643 | RSS: Main: 218824704 14:47:01 INFO - PROCESS | 1643 | 14:47:03 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 14:47:04 INFO - PROCESS | 1643 | RSS: Main: 233291776 14:47:04 INFO - PROCESS | 1643 | 14:47:07 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 14:47:08 INFO - PROCESS | 1643 | RSS: Main: 331132928 14:47:08 INFO - PROCESS | 1643 | 14:47:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 14:47:10 INFO - PROCESS | 1643 | RSS: Main: 229515264 14:47:10 INFO - PROCESS | 1643 | 14:47:12 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:13 INFO - PROCESS | 1643 | RSS: Main: 230064128 14:47:13 INFO - PROCESS | 1643 | 14:47:16 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:16 INFO - PROCESS | 1643 | RSS: Main: 267087872 14:47:16 INFO - PROCESS | 1643 | 14:47:19 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:20 INFO - PROCESS | 1643 | RSS: Main: 268308480 14:47:20 INFO - PROCESS | 1643 | 14:47:23 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 14:47:23 INFO - PROCESS | 1643 | RSS: Main: 265433088 14:47:23 INFO - PROCESS | 1643 | 14:47:25 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:25 INFO - PROCESS | 1643 | RSS: Main: 240128000 14:47:25 INFO - PROCESS | 1643 | 14:47:27 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:28 INFO - PROCESS | 1643 | RSS: Main: 243634176 14:47:28 INFO - PROCESS | 1643 | 14:47:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:31 INFO - PROCESS | 1643 | RSS: Main: 254722048 14:47:31 INFO - PROCESS | 1643 | 14:47:33 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:34 INFO - PROCESS | 1643 | RSS: Main: 266223616 14:47:34 INFO - PROCESS | 1643 | 14:47:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:38 INFO - PROCESS | 1643 | RSS: Main: 260718592 14:47:38 INFO - PROCESS | 1643 | 14:47:39 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 14:47:40 INFO - PROCESS | 1643 | RSS: Main: 304885760 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | __start_tp_report 14:47:40 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 14:47:40 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 14:47:40 INFO - PROCESS | 1643 | |i|pagename|runs| 14:47:40 INFO - PROCESS | 1643 | |0;ai-astar;115;113;112;113;113;112;112;111;112;113 14:47:40 INFO - PROCESS | 1643 | |1;audio-beat-detection;142;108;108;142;127;139;138;113;148;107 14:47:40 INFO - PROCESS | 1643 | |2;audio-dft;184;181;180;184;184;182;182;183;182;181 14:47:40 INFO - PROCESS | 1643 | |3;audio-fft;79;57;59;88;60;59;58;58;79;57 14:47:40 INFO - PROCESS | 1643 | |4;audio-oscillator;85;70;92;70;69;71;91;95;69;89 14:47:40 INFO - PROCESS | 1643 | |5;imaging-gaussian-blur;87;85;89;131;135;84;87;85;87;87 14:47:40 INFO - PROCESS | 1643 | |6;imaging-darkroom;92;93;92;93;93;93;93;109;149;121 14:47:40 INFO - PROCESS | 1643 | |7;imaging-desaturate;83;83;83;85;82;82;85;83;86;85 14:47:40 INFO - PROCESS | 1643 | |8;json-parse-financial;55;53;51;51;53;53;55;75;87;54 14:47:40 INFO - PROCESS | 1643 | |9;json-stringify-tinderbox;64;71;70;74;69;66;67;73;66;68 14:47:40 INFO - PROCESS | 1643 | |10;stanford-crypto-aes;83;82;94;102;100;83;80;86;88;88 14:47:40 INFO - PROCESS | 1643 | |11;stanford-crypto-ccm;136;135;136;135;133;131;136;139;168;155 14:47:40 INFO - PROCESS | 1643 | |12;stanford-crypto-pbkdf2;211;163;166;159;162;160;160;160;161;159 14:47:40 INFO - PROCESS | 1643 | |13;stanford-crypto-sha256-iterative;66;66;67;68;66;66;66;65;65;66 14:47:40 INFO - PROCESS | 1643 | __end_tp_report 14:47:40 INFO - PROCESS | 1643 | __start_cc_report 14:47:40 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1868 14:47:40 INFO - PROCESS | 1643 | __end_cc_report 14:47:40 INFO - PROCESS | 1643 | __startTimestamp1484261260031__endTimestamp 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | ------- Summary: start ------- 14:47:40 INFO - PROCESS | 1643 | Number of tests: 14 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.07 (1.0%) stddev-sans-first:0.71 14:47:40 INFO - PROCESS | 1643 | Values: 115.0 113.0 112.0 113.0 113.0 112.0 112.0 111.0 112.0 113.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:138.50 stddev:16.58 (12.0%) stddev-sans-first:16.70 14:47:40 INFO - PROCESS | 1643 | Values: 142.0 108.0 108.0 142.0 127.0 139.0 138.0 113.0 148.0 107.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.50 stddev:1.42 (0.8%) stddev-sans-first:1.36 14:47:40 INFO - PROCESS | 1643 | Values: 184.0 181.0 180.0 184.0 184.0 182.0 182.0 183.0 182.0 181.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.50 stddev:11.75 (19.7%) stddev-sans-first:11.38 14:47:40 INFO - PROCESS | 1643 | Values: 79.0 57.0 59.0 88.0 60.0 59.0 58.0 58.0 79.0 57.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:87.00 stddev:11.15 (12.8%) stddev-sans-first:11.68 14:47:40 INFO - PROCESS | 1643 | Values: 85.0 70.0 92.0 70.0 69.0 71.0 91.0 95.0 69.0 89.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:87.00 stddev:19.73 (22.7%) stddev-sans-first:20.68 14:47:40 INFO - PROCESS | 1643 | Values: 87.0 85.0 89.0 131.0 135.0 84.0 87.0 85.0 87.0 87.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:93.00 stddev:18.91 (20.3%) stddev-sans-first:19.65 14:47:40 INFO - PROCESS | 1643 | Values: 92.0 93.0 92.0 93.0 93.0 93.0 93.0 109.0 149.0 121.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:84.00 stddev:1.42 (1.7%) stddev-sans-first:1.48 14:47:40 INFO - PROCESS | 1643 | Values: 83.0 83.0 83.0 85.0 82.0 82.0 85.0 83.0 86.0 85.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:54.50 stddev:12.17 (22.3%) stddev-sans-first:12.83 14:47:40 INFO - PROCESS | 1643 | Values: 55.0 53.0 51.0 51.0 53.0 53.0 55.0 75.0 87.0 54.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.50 stddev:3.22 (4.6%) stddev-sans-first:2.92 14:47:40 INFO - PROCESS | 1643 | Values: 64.0 71.0 70.0 74.0 69.0 66.0 67.0 73.0 66.0 68.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:84.50 stddev:7.65 (9.1%) stddev-sans-first:7.84 14:47:40 INFO - PROCESS | 1643 | Values: 83.0 82.0 94.0 102.0 100.0 83.0 80.0 86.0 88.0 88.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:136.00 stddev:11.72 (8.6%) stddev-sans-first:12.32 14:47:40 INFO - PROCESS | 1643 | Values: 136.0 135.0 136.0 135.0 133.0 131.0 136.0 139.0 168.0 155.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:161.50 stddev:15.92 (9.9%) stddev-sans-first:2.26 14:47:40 INFO - PROCESS | 1643 | Values: 211.0 163.0 166.0 159.0 162.0 160.0 160.0 160.0 161.0 159.0 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - PROCESS | 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 14:47:40 INFO - PROCESS | 1643 | Values: 66.0 66.0 67.0 68.0 66.0 66.0 66.0 65.0 65.0 66.0 14:47:40 INFO - PROCESS | 1643 | -------- Summary: end -------- 14:47:40 INFO - PROCESS | 1643 | 14:47:40 INFO - TEST-INFO | 1643: exit 0 14:47:40 INFO - TEST-OK | kraken | took 57762ms 14:47:40 INFO - SUITE-END | took 1172s 14:47:41 INFO - Completed test suite (00:19:33) 14:47:41 INFO - javascript benchmark 14:47:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3451.2407270400504, 3475.47867819827, 3490.2495963367887, 3502.8440614597152, 3552.8756493522715, 5652.208690783294, 5664.915026274609, 5719.313682358113, 5721.199032135494, 5748.942510574898, 5663.8584035399135, 5736.569757268201, 5743.994800909845, 5757.68332741699, 5759.020966435705, 5148.871278218037, 5167.974160129213, 5203.86990325243, 5217.191335343028, 5217.191335343028, 5125.948740512603, 5141.4087379951225, 5156.819511317105, 5278.788848446057, 5280.471952804727, 5178.585713142939, 5207.817726379578, 5209.114450543417, 5215.478452154774, 5221.582273418117, 5205.0, 5226.033183860979, 5270.051390749663, 5273.683578985273, 5317.202419637086, 5080.085584594772, 5131.0, 5208.348956380452, 5230.058589453897, 5240.082985477527, 4071.6335529802163, 5602.355729091166, 5617.4382561743905, 5636.15457681347, 5711.514521265697, 6177.289611694623, 6177.320494745574, 6193.814185574395, 6254.499640028786, 6294.055891616248, 5243.659162154448, 6283.439156346621, 6337.112804207414, 6344.841378965517, 6354.237491501003, 5670.149477578355, 5691.68695721731, 5738.569607279387, 5741.712914354265, 5804.419558044204, 6290.811275661646, 6315.431611154926, 6331.841703957438, 6333.334999825044, 6340.112384266206, 6155.384461553898, 6159.1069294951985, 6161.507079433634, 6167.938320616737, 6172.22847144107, 6129.14485165794, 6197.318294987548, 6228.22147231596, 6284.277308109535, 6316.147320111726, 6140.6929653517145, 6146.78486252979, 6168.19813424252, 6207.410296021871, 6211.409916057967, 6199.473044791243, 6217.96891015542, 6232.906506402408, 6233.719482623293, 6249.7187626556915, 4439.711418757835, 4712.246040633482, 4725.842168668698, 4913.0, 4958.702477851269, 3901.882943511699, 4500.932486012713, 4518.661100417482, 4526.683132180716, 4538.863834084983, 5708.771649134072, 5719.656820590694, 5731.426857314235, 5738.397468265855, 5750.827475175752, 6141.486007784275, 6192.195014648157, 6211.782587609502, 6218.751249949952, 6236.875262494725, 5768.3654797972185, 5811.796587119515, 5812.215350927655, 5831.7667293307795, 5852.917210316105, 5410.702411367334, 5423.159410291411, 5426.728663566806, 5430.456954304538, 5444.074507333763, 6217.347178546188, 6248.156498872594, 6267.561270711098, 6276.309605943343, 6308.116863639002, 5171.3018742469285, 6223.3465486125115, 6264.968675156595, 6272.466840318624, 6284.340144284967, 6298.748050077946, 6302.180716506825, 6307.24313082433, 6338.11266422692, 6342.968285158545, 6246.125542424155, 6249.375062493896, 6252.562320637512, 6263.342349053284, 6267.905981410374, 6165.784197553244, 6203.379662033761, 6331.651759153291, 6341.682915854281, 6343.841403964938, 6095.847603809941, 6104.847378815565, 6112.938870611415, 6157.291911430243, 6176.258848938156, 5980.611260268069, 6101.884493623382, 6121.785737499166, 6158.876822463615, 6162.599431036968, 5808.303003639421, 6011.87976240464, 6027.487663548647, 6027.57806953509, 6041.697915104315, 6007.8197654070445, 6010.759569617341, 6031.60794548353, 6109.419605137505, 6140.938590614037, 5991.161237426677, 5993.0, 5996.670183139795, 6002.759889604542, 6018.458338749533], "value": 5693.700636241871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.9110960027195, 503.7758247458676, 519.1771042897008, 520.8828013696916, 538.647186093109, 29915.401691966148, 32617.18457038575, 34356.79751208708, 34435.31129377411, 34531.0, 35703.285934281295, 45272.54727452724, 46045.07909841801, 46093.76953115238, 48143.75928120363, 10088.991100889907, 10264.178865690765, 10268.0, 10276.280660353777, 10284.331518451314, 9922.702318930407, 9961.302708810386, 10078.244131690117, 10088.192944564416, 10092.646757363495, 9406.388584742004, 9698.418094914292, 12323.383830808469, 12538.874611253908, 12575.622731318075, 12371.948384387293, 12516.31160286193, 12517.561885334015, 12535.498580056787, 12580.559680411234, 12480.75038499234, 12516.436760345807, 12524.499020039279, 12533.874661253361, 12554.058445616523, 42757.786211069055, 42981.14037719228, 42982.785086074684, 42996.14007719828, 43120.56879431197, 3713.286713286713, 3713.294474049922, 4121.175764847043, 4122.196171746511, 4211.97894010531, 32020.839895800604, 32083.679163208304, 32454.0, 32960.17599560006, 33028.83485582557, 3359.8656053757823, 3371.0561042908025, 3429.0, 3431.897043088711, 3479.1650003998857, 518377.408112957, 520570.0, 520985.0, 521318.0, 521384.3930780322, 62762.0, 63235.6838215806, 63273.683631581545, 63303.36696632975, 63305.36694633087, 35821.31340149499, 36276.911692649264, 36485.45271820925, 36490.8175459121, 37686.62313376886, 17692.557686057953, 17876.106194690212, 17955.0, 17955.820441795677, 17955.910220448815, 13306.534271300457, 13427.925765938702, 13446.529371472147, 13455.394507247198, 13466.528671496451, 17620.94274343518, 19758.901205494167, 19874.403767886986, 20246.291379801638, 20286.594268114553, 7249.565026098346, 7582.090149182023, 8515.531645759544, 8552.828943421096, 8593.269572086443, 853.4196746212511, 970.7233438470003, 988.6836212412103, 1087.505185140759, 1139.2537887683582, 31931.0, 32017.839910800296, 32025.839870800963, 32286.677133228837, 32785.83607081997, 1110.3337997201777, 1112.5494174859195, 1149.0, 1185.199990006742, 1194.331174542259, 16401.015939043697, 16524.4216452426, 16546.007239565664, 16583.6683266334, 16988.06565638902, 706923.0, 715071.0, 716856.0, 717437.0, 720485.0, 53988.0, 54494.0, 54546.454535454934, 56913.43086569164, 61632.691836541424, 1221.2916508425092, 1305.2690493323769, 1411.1815147214795, 1413.8656827601362, 1437.367558274356, 31068.689313107483, 32866.50700239546, 33061.504077438374, 33119.337613248084, 33606.0, 52218.0, 52815.207771882684, 52841.0, 52909.47090529199, 52912.941741165734, 554085.0, 555889.0, 556226.0, 557967.0, 803387.0, 24577.50844983126, 24815.87592062028, 24883.253502394957, 24886.626700599143, 45989.310160348294, 48246.27630585614, 48724.26913596228, 52590.211146832065, 52943.20585191302, 53200.0, 41683.58316416797, 43283.0, 43494.0, 43718.0, 44683.329750053126, 41975.53085641988, 42319.5768042328, 43158.13683726245, 43660.56339436565, 44340.778296108314, 41590.58409415867, 42260.0, 42449.78775106105, 42556.0, 43065.569344306154, 32352.0, 34908.60365585348, 35511.82244088763, 37099.0320774332, 37781.43327850029, 27331.0, 27339.86330068337, 27354.0, 27362.0, 27841.721582784725], "value": 21118.08837010023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.1366851920218, 388.6210944329281, 389.3303517949127, 396.60141557734465, 418.481083456514, 14345.0, 16279.0, 21069.05189266483, 21856.45358866029, 21880.890595547018, 20957.685634715453, 21061.789382106173, 21816.90915454229, 21930.903454827276, 22103.889480552614, 5890.381509941448, 6248.531360147985, 6250.812475625738, 6255.62466252024, 6260.968695156541, 3456.9110730120055, 6107.786227482039, 6169.845753856167, 6212.192414986068, 6230.439260466557, 6215.782447614334, 6235.719392627343, 6241.0, 6245.937540624604, 6253.1245625612455, 6019.5485338599565, 6070.150178974947, 6146.231721034871, 6153.292371377304, 6169.290531588835, 4594.287885377772, 5150.484951504857, 5356.9732151339385, 5372.247885296023, 5374.193870919355, 26449.603255951177, 26882.46235075307, 27075.864620676966, 27218.591721124, 27394.904203831822, 2300.0346689118846, 2413.3604594782396, 2487.639292302606, 3071.66211716711, 3077.79965813333, 15840.128792916385, 15862.762058569131, 15958.281877315549, 16077.598060048475, 16738.74891876623, 1933.4006457998066, 1978.5251539630528, 1997.7502812148482, 2012.5572374077678, 2040.8877511736848, 118385.81614183834, 120954.0, 123112.38443807814, 123684.0, 125904.11143832942, 10930.398828064373, 10992.395418251914, 11429.542818287342, 11505.712357191138, 11715.765684686428, 12856.421461034275, 13601.979851510978, 14337.139771613736, 14370.065945713495, 14408.639784005483, 8541.743747687578, 8800.559972001374, 8898.510581918057, 8938.68714594986, 9050.411723237969, 7507.324340809353, 9029.77425564353, 9079.954600226956, 9092.909070909338, 9116.36185467011, 5623.381428042912, 6733.360330768569, 6808.8978665320055, 6842.6578671066245, 6857.417119544894, 1807.9186436610385, 1918.9904050479938, 1922.7884932657396, 1928.9421317360502, 1929.2668785861283, 764.3273918951287, 890.528020149322, 919.9862002069974, 948.83869742144, 963.7253382785873, 16304.0, 16700.58248543796, 22571.0, 22632.0, 23028.0, 861.9525926074001, 990.4948476277151, 999.8400255959011, 1022.8005538919839, 1044.9007344302279, 11212.27120237182, 12258.81611775824, 12387.318697471726, 12482.75034499305, 12525.185862918881, 619368.0, 621078.0, 631093.8445307744, 642327.0, 642415.0, 116265.41867290779, 122639.0, 123996.38001809933, 129086.70913290935, 129967.35016324857, 862.4264863865459, 949.6533765175661, 1013.9746506337401, 1053.4995876958537, 1054.3199636234585, 19806.702899456806, 20062.49843753918, 20563.69154462714, 20658.17367305291, 20671.06980185865, 43751.56248437475, 45127.0, 47841.0, 53581.464185359204, 58587.0, 73450.0, 85927.0, 86775.56612216898, 87453.1254687445, 88516.0, 6886.0, 8064.475809072626, 8145.674173033012, 8513.40406171562, 8610.364030834122, 12200.328981905725, 13199.538016169772, 13605.591832245049, 13706.794398083837, 13707.314634268047, 11229.88770112321, 11854.585089521825, 11982.041436685218, 11997.460114294703, 12073.456694448947, 11370.090392768725, 11373.715657108638, 11453.828192577284, 11736.119791015537, 12004.639860804189, 11394.25937314072, 11558.595449159238, 11784.646460606196, 12163.75672486563, 12200.206986545845, 6902.482313826383, 8156.306713929145, 8182.263596276363, 8609.354298427768, 8612.741617751477, 9517.381370210915, 11525.366104864313, 11610.825837612612, 11628.360440175871, 11888.643340699793], "value": 10027.641805966816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.794088827564, 1529.6787674588336, 1750.7461418094376, 1817.4456790678855, 1933.39098184072, 8580.313574914007, 9151.95424022879, 9164.037776033512, 9166.81666366674, 9217.354785165033, 7930.801729956754, 8169.959150204256, 8674.0, 8834.60244289007, 8862.867056994133, 2343.2970108967284, 2376.7979721723586, 2380.2740164249985, 2382.4163080045414, 2384.284714585617, 2071.1508281604547, 2315.270689732729, 2363.5745565798147, 2378.9643155352596, 2396.1613435297595, 1970.48767320497, 2359.775821296974, 2373.8931748071377, 2385.6997936124767, 2402.159244264511, 2328.697269354973, 2342.824288178385, 2351.4356554426986, 2353.7528559501347, 2378.2389635316704, 2366.0062773635113, 2382.4639456122236, 2385.4155731845635, 2387.1167667962964, 2388.0686532252435, 9065.048169942127, 9151.496667683276, 9154.31342649304, 9164.358494905358, 9174.220191283683, 5279.023380674587, 5393.892122157574, 5468.507834294933, 5480.6437581557075, 5570.387257401682, 3508.947365789515, 3596.37063513884, 3673.834677439522, 3681.44778283257, 3682.4844521766972, 1051.3113910388709, 1067.3969207397795, 1074.0601973273385, 1077.7682798198425, 1092.415557676647, 12065.155439119266, 12084.758304833855, 12108.636740897788, 12124.696882578006, 12139.0, 4657.790399432034, 4662.557057079572, 4843.588294994895, 4848.296996935495, 4920.114379411741, 10237.385756854612, 10248.948755256177, 10256.692299231036, 10265.12746416563, 10271.075603195599, 5515.972420137874, 5516.779328826802, 5520.309961254843, 5523.944760552424, 5528.281323428009, 4577.862664120082, 4729.621630269639, 4902.0, 5004.699718016931, 5060.962502686941, 4008.518977722692, 4045.7572545647354, 4098.877033688994, 4133.9793301033305, 4165.354370072643, 1306.3859985806655, 1313.3367649337024, 1317.8616245294297, 1321.8347706536683, 1325.4830616059744, 860.0367588301143, 891.6166048599165, 915.2357781252729, 920.4845286639503, 948.5209968965628, 5786.826395208066, 5964.373740757158, 6014.488768454643, 6082.178905847654, 6119.990201616683, 384.7691385168876, 427.46993727777954, 446.1990726645679, 446.2436170690713, 446.26366495282394, 3674.2651469706166, 3674.3202507536193, 3709.870154544632, 3750.8124593770203, 3789.0716774390453, 10455.738606534898, 10989.340639561651, 11006.449677516091, 11016.834747478793, 11053.392063436588, 10930.070943969693, 10947.726306842233, 10953.83569246462, 10977.83533246986, 11013.83479247812, 8217.260446559838, 8260.421770476129, 8423.410361274775, 8437.451565648336, 8448.662053518035, 5578.442155784389, 5618.494335509824, 5723.656580605177, 5803.651780892991, 5834.18321434991, 9997.650082247086, 10031.347962382422, 10129.442880641636, 10250.821155567206, 10273.02406271403, 10244.846327304947, 10394.116500097576, 10489.737756556147, 10522.31604945676, 10609.045185933302, 6946.409555187865, 7322.340989310987, 7579.5073320234005, 7708.306252437307, 7817.765467035998, 8638.26574741154, 8717.52053637056, 8718.694845680371, 8720.561107417205, 8726.869096963677, 7574.772756817304, 7642.082950045808, 7682.385409167141, 7829.060512738508, 7842.882356764767, 7467.962660186664, 7505.699772009277, 7564.357029652321, 7568.924310756822, 7681.846363072819, 7010.859782804213, 7138.286171382821, 7151.499395042297, 7155.642217889189, 7156.1770396403, 4901.09329773993, 4933.77797999098, 4939.43196532389, 4972.129877271391, 4979.153543897619, 4932.4327702314695, 5015.974920125376, 5045.142325804695, 5130.358705161855, 5142.614303927296], "value": 4564.055281740418, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.85577778444133, 308.7499125708175, 315.2261198757052, 320.5256220793226, 323.6714734544436, 5345.866353341164, 5448.863778405537, 5454.481824226702, 5460.863478413042, 5465.9726701366535, 4663.790129444174, 4769.713817170964, 5052.014857102867, 5148.485151484859, 5436.320459942507, 3139.544766008927, 3838.558565764945, 4011.83952641894, 4017.0, 4039.555648878621, 3188.984055079721, 4023.4769479967563, 4077.979610101945, 4099.749576379203, 4123.60825721556, 3954.8022598870084, 4051.534073581546, 4075.3683179107284, 4079.4288799568085, 4103.548609652936, 3387.3225354929114, 3421.230223199785, 4092.754434733911, 4095.1809638072505, 4105.58944105587, 2993.2938225211637, 3170.7780455368134, 3191.760617953663, 3311.586051743532, 3562.8040457774814, 4383.956160438419, 5130.460422091089, 5139.792148845018, 5200.92198617021, 5256.842294731126, 4427.645788336926, 4581.908361832745, 4597.839075632337, 4604.145429833491, 4646.744429056401, 4772.284157376422, 5194.22086687, 5501.5420913457965, 5521.889562208774, 5559.305086864142, 3274.918127046819, 3942.7437216581116, 3954.2486927483687, 3986.740861843971, 4006.7996600169877, 5407.945920540784, 5833.57077516007, 5842.474177324061, 5847.649141051551, 5867.823965281048, 3091.4280858041334, 3233.644299127094, 3749.868754593631, 3872.786996715208, 3886.620249811333, 3610.476480910306, 3666.651668091527, 3947.2105578883766, 3949.328614135604, 3971.900702482403, 4055.8986025349604, 4245.384419259251, 4571.805533344013, 4647.279671650899, 4657.650676199299, 4629.328747331618, 4661.720296782204, 5289.709066001406, 5292.338457692788, 5560.833175004756, 1199.7840388729937, 1242.931638759877, 1288.7229245712028, 1312.6455856918578, 1327.5154568582398, 853.4111463090447, 882.5631312500353, 882.6381183714647, 935.3265648732902, 966.4539535162611, 4386.363977223348, 4902.965269413154, 5218.295530103387, 5228.477152284741, 5245.606579506552, 5626.071698169838, 5645.491905728422, 5663.348714897757, 5719.8570035749435, 5783.94216057834, 4180.770057646859, 5273.683578985273, 5343.251944727741, 5388.572028412474, 5407.215953686693, 2809.9578506322423, 2994.82031078136, 3026.72759451646, 3032.150997720642, 3042.0721679887406, 4866.975665121722, 5735.719387270931, 6010.459058684652, 6066.969665151646, 6131.63210207389, 5021.397432308147, 5111.412187598399, 5690.130711116398, 5846.4153584642045, 5933.970330148408, 5184.766685499086, 5407.70257635826, 5924.51887028243, 5959.344472108065, 5967.6419414835245, 4529.6602754794185, 4846.975765121152, 5477.616566840283, 5741.1388291756575, 5825.475707186373, 5711.971440142773, 5729.169270455677, 5751.424857514216, 5763.077907534775, 5767.904098221325, 5746.511546518593, 5993.190919225849, 6010.368911264429, 6070.0, 6242.157308763259, 3901.96098039016, 3902.434147048719, 3929.8821035368983, 3975.157762200041, 3986.063275130284, 5071.5656484888195, 5135.460776618401, 5901.0, 5952.76188952437, 5966.313873904556, 4334.45819272591, 5268.57851371897, 5480.91778623313, 5776.884462310646, 5854.326752423526, 5188.22176673502, 5648.5481161507805, 5651.0, 5720.542356611544, 5747.758374234136, 5282.47175282484, 5540.307461567304, 5578.721063946705, 5586.273784408164, 5610.298712660918, 5076.619253555924, 5139.511746384088, 5163.66436181647, 5611.298587676541, 5633.549316054788, 4583.9312410313205, 5546.58400619947, 5548.69482178484, 5569.303837020372, 5618.39875635442], "value": 4074.5073972788555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8320211941716, 719.5898337947369, 821.5194111444805, 845.826605545863, 861.272224969901, 16296.18519074046, 17050.74423883641, 17055.573610659725, 17090.401835935743, 17126.914365428154, 15252.161131137784, 15342.923285383586, 15358.923205383957, 15364.462243821468, 15370.846291537082, 725.6625669063884, 738.726671131682, 884.995575022124, 897.833900728364, 910.4491782471608, 914.8399030169694, 917.6742256498947, 920.2729843423688, 924.7179610218881, 925.0379605210607, 984.2175470500933, 985.2019863910256, 986.1075726467558, 987.3039507147444, 989.3964681544252, 983.9655612053543, 985.418603024212, 985.6303886042734, 985.7190700650316, 989.4310771306527, 736.6169591812228, 737.4874462248739, 739.6819367671899, 741.1735914455397, 743.6021728375347, 15583.922080389526, 15587.766183507256, 15598.220088995506, 15655.13896735679, 15663.530094097081, 13586.660333491644, 13673.974451916147, 14028.298585070706, 14050.227237501933, 14053.08654937436, 13023.348832558335, 13056.151350162305, 13353.465861365534, 13599.0, 14049.5082672107, 4829.251466022772, 4862.5380588844, 4967.975160124212, 5000.949990500085, 5025.221090730943, 128264.0760388595, 131323.0, 132025.6797432023, 132118.0, 132959.33520332433, 8992.775180620536, 11047.613333533287, 11599.304041757352, 11640.650780476599, 11655.242409243372, 21320.253791117546, 21871.453213669785, 21930.0, 21954.560908781736, 22046.228382006553, 7894.64474098667, 7993.32056775169, 8079.232472915063, 8378.036525799489, 8430.765847050536, 3837.9808100959317, 4540.228161212602, 4713.080949214938, 4796.112719146969, 4822.855314340575, 2987.3129180288656, 3534.4874993125854, 3605.6574625410544, 3646.5441819772527, 3652.908677283089, 560.7028275014248, 660.5310229736845, 666.7832954289876, 675.8445557521798, 678.7420780103529, 545.3319683387818, 588.805694120939, 617.5368473644767, 626.5932980458899, 645.2805122288709, 9047.638094476148, 9368.34421590482, 9448.385854919408, 9511.857322140173, 9609.423434593808, 630.6562923206864, 633.8383712153463, 651.3356376495948, 652.5823472977298, 675.9594424334457, 4282.678799090081, 4604.7927843247135, 4642.117997580449, 4653.348061438141, 4709.599684026827, 124911.0, 162275.829312802, 163470.0, 163517.18241408718, 175528.12235938737, 119490.0, 119743.0, 121071.0, 124898.0, 132056.0, 107453.38819917708, 115812.0, 116498.0, 118792.0, 124777.37611312067, 9934.552945117342, 10430.634927777492, 10536.0, 10590.682279531626, 10628.468576570986, 53110.0, 61604.383956159865, 62304.376956229855, 62822.0, 63369.09892703226, 95929.5203523978, 98066.65970325892, 101267.49366253417, 103063.4846825761, 104383.4780826091, 13454.730905382034, 13543.525976590772, 13755.31223438804, 13791.862081379459, 14132.646683832987, 14763.778543321643, 15328.386864525293, 15430.84569154339, 15844.207789610704, 16677.332906683598, 12904.41930113166, 13214.307099658445, 14086.01397902137, 14419.567412977207, 14739.410423582936, 13876.791848122488, 13916.791248131489, 14712.485063022743, 14857.0, 15323.846761532242, 13572.1856688599, 13892.93053534726, 14676.41294348214, 14902.180380078766, 15111.924440377728, 11580.710482238012, 11749.177557571229, 11838.526458941546, 11918.0, 12019.519219231133, 10611.41637209961, 10934.890651093387, 11912.463939122934, 11954.222975506564, 12138.211016283913], "value": 8223.201897023173, "unit": "score"}], "name": "dromaeo_css", "value": 7544.446532632025, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 112.0, 113.0, 113.0, 112.0, 112.0, 111.0, 112.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 108.0, 142.0, 127.0, 139.0, 138.0, 113.0, 148.0, 107.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 180.0, 184.0, 184.0, 182.0, 182.0, 183.0, 182.0, 181.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 59.0, 88.0, 60.0, 59.0, 58.0, 58.0, 79.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 92.0, 70.0, 69.0, 71.0, 91.0, 95.0, 69.0, 89.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 131.0, 135.0, 84.0, 87.0, 85.0, 87.0, 87.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 109.0, 149.0, 121.0], "value": 102.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 85.0, 82.0, 82.0, 85.0, 83.0, 86.0, 85.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 51.0, 51.0, 53.0, 53.0, 55.0, 75.0, 87.0, 54.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 70.0, 74.0, 69.0, 66.0, 67.0, 73.0, 66.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 94.0, 102.0, 100.0, 83.0, 80.0, 86.0, 88.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 136.0, 135.0, 133.0, 131.0, 136.0, 139.0, 168.0, 155.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 163.0, 166.0, 159.0, 162.0, 160.0, 160.0, 160.0, 161.0, 159.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1438.5, "alertThreshold": 2.0}]} 14:47:41 INFO - Return code: 0 14:47:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:47:41 INFO - # TBPL SUCCESS # 14:47:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:47:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:47:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:47:41 INFO - 2017-01-12 14:47:41.337 screenresolution[1647:10044] starting screenresolution argv=screenresolution get 14:47:41 INFO - 2017-01-12 14:47:41.340 screenresolution[1647:10044] Display 0: 1600x1200x32@60 14:47:41 INFO - 2017-01-12 14:47:41.345 screenresolution[1648:10047] starting screenresolution argv=screenresolution list 14:47:41 INFO - Available Modes on Display 0 14:47:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:47:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:47:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:47:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:47:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:47:41 INFO - Intel Iris: 14:47:41 INFO - Chipset Model: Intel Iris 14:47:41 INFO - Type: GPU 14:47:41 INFO - Bus: Built-In 14:47:41 INFO - VRAM (Dynamic, Max): 1536 MB 14:47:41 INFO - Vendor: Intel (0x8086) 14:47:41 INFO - Device ID: 0x0a2e 14:47:41 INFO - Revision ID: 0x0009 14:47:41 INFO - Displays: 14:47:41 INFO - Display: 14:47:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:47:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:47:41 INFO - Display Serial Number: 1600x1200 60 14:47:41 INFO - Main Display: Yes 14:47:41 INFO - Mirror: Off 14:47:41 INFO - Online: Yes 14:47:41 INFO - Rotation: Supported 14:47:41 INFO - Return code: 0 14:47:41 INFO - Running post-action listener: _resource_record_post_action 14:47:41 INFO - [mozharness: 2017-01-12 22:47:41.580763Z] Finished run-tests step (success) 14:47:41 INFO - Running post-run listener: _resource_record_post_run 14:47:41 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37843968; Write bytes: 497318912; Read time: 243; Write time: 1576 14:47:41 INFO - TinderboxPrint: CPU usage
53.3% 14:47:41 INFO - TinderboxPrint: I/O read bytes / time
37,843,968 / 243 14:47:41 INFO - TinderboxPrint: I/O write bytes / time
497,318,912 / 1,576 14:47:41 INFO - TinderboxPrint: CPU idle
2,233.7 (46.7%) 14:47:41 INFO - TinderboxPrint: CPU system
954.4 (20.0%) 14:47:41 INFO - TinderboxPrint: CPU user
1,593.6 (33.3%) 14:47:41 INFO - TinderboxPrint: Swap in / out
233,328,640 / 0 14:47:41 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186010112; Write bytes: 179398656; Read time: 16696; Write time: 408 14:47:41 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36881408; Write bytes: 297853952; Read time: 229; Write time: 1108 14:47:42 INFO - Running post-run listener: _upload_blobber_files 14:47:42 INFO - Blob upload gear active. 14:47:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:42 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 14:47:42 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'] 14:47:42 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 14:47:42 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:47:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:43 INFO - (blobuploader) - INFO - Done attempting. 14:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:44 INFO - (blobuploader) - INFO - Done attempting. 14:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:46 INFO - (blobuploader) - INFO - Done attempting. 14:47:46 INFO - (blobuploader) - INFO - Iteration through files over. 14:47:46 INFO - Return code: 0 14:47:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:47:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:47:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3adde2724d388294eec6a16706da37b8a4822d9666dd70a056db4592213b3fc20291640c4141af7c4800421bb5cd3175168143b4f99662a1519addabf639ae46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c229e07605814cee694e7096631063b08cccd5bdad7ab0296e560eb03ca78acabf7f84fcdfe1d6cff2d1266b3bd257bef89c62900413e1e84e3623662654bb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb2bf155301c2e7319f61728c6e49276a769fe0450b1d23fa85f4c6019ee48bd23950bf84235d1f2e455488530ca7a1ce0c8560c43a3fc3761c1937e9e8ebea9"} 14:47:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:47:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:47:46 INFO - Contents: 14:47:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3adde2724d388294eec6a16706da37b8a4822d9666dd70a056db4592213b3fc20291640c4141af7c4800421bb5cd3175168143b4f99662a1519addabf639ae46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c229e07605814cee694e7096631063b08cccd5bdad7ab0296e560eb03ca78acabf7f84fcdfe1d6cff2d1266b3bd257bef89c62900413e1e84e3623662654bb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb2bf155301c2e7319f61728c6e49276a769fe0450b1d23fa85f4c6019ee48bd23950bf84235d1f2e455488530ca7a1ce0c8560c43a3fc3761c1937e9e8ebea9"} 14:47:46 INFO - Running post-run listener: copy_logs_to_upload_dir 14:47:46 INFO - Copying logs to upload dir... 14:47:46 INFO - mkdir: /builds/slave/test/build/upload/logs 14:47:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.037143 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-12 14:47:46.985424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 14:47:46.989145) ========= 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.ANthf4ax6O/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.jqSH6mK8KB/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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/3adde2724d388294eec6a16706da37b8a4822d9666dd70a056db4592213b3fc20291640c4141af7c4800421bb5cd3175168143b4f99662a1519addabf639ae46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c229e07605814cee694e7096631063b08cccd5bdad7ab0296e560eb03ca78acabf7f84fcdfe1d6cff2d1266b3bd257bef89c62900413e1e84e3623662654bb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb2bf155301c2e7319f61728c6e49276a769fe0450b1d23fa85f4c6019ee48bd23950bf84235d1f2e455488530ca7a1ce0c8560c43a3fc3761c1937e9e8ebea9"} build_url:https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011053 build_url: 'https://queue.taskcluster.net/v1/task/XTLGoS2ITOyF1svgPxBPOA/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/3adde2724d388294eec6a16706da37b8a4822d9666dd70a056db4592213b3fc20291640c4141af7c4800421bb5cd3175168143b4f99662a1519addabf639ae46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5c229e07605814cee694e7096631063b08cccd5bdad7ab0296e560eb03ca78acabf7f84fcdfe1d6cff2d1266b3bd257bef89c62900413e1e84e3623662654bb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb2bf155301c2e7319f61728c6e49276a769fe0450b1d23fa85f4c6019ee48bd23950bf84235d1f2e455488530ca7a1ce0c8560c43a3fc3761c1937e9e8ebea9"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 14:47:47.037373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:47:47.038013) ========= 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.ANthf4ax6O/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.jqSH6mK8KB/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005114 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:47:47.090784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 14:47:47.094225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 14:47:47.094622) ========= ========= Total master_lag: 0.22 =========