builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0181 starttime: 1470971399.51 results: success (0) buildid: 20160811183317 builduid: f5472141520f4406b8ba9cf0d7157895 revision: ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.507700) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.508330) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.508684) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.534018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.534417) ========= 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.fwEmdslo7s/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.c5i4fMZorw/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-11 20:09:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.2M=0.001s 2016-08-11 20:09:59 (21.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.674262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.674657) ========= 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.fwEmdslo7s/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.c5i4fMZorw/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.027939 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:09:59.724096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 20:09:59.724505) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fwEmdslo7s/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.c5i4fMZorw/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-11 20:09:59,797 truncating revision to first 12 chars 2016-08-11 20:09:59,797 Setting DEBUG logging. 2016-08-11 20:09:59,797 attempt 1/10 2016-08-11 20:09:59,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ebbebe3e2aee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 20:10:00,089 unpacking tar archive at: autoland-ebbebe3e2aee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562927 ========= master_lag: 0.59 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 20:10:00.876597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 20:10:00.876973) ========= script_repo_revision: ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 20:10:00.877388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 20:10:00.877679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 20:10:00.953287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-11 20:10:00.953707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fwEmdslo7s/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.c5i4fMZorw/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:01 INFO - MultiFileLogger online at 20160811 20:10:01 in /builds/slave/test 20:10:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:10:01 INFO - {'append_to_log': False, 20:10:01 INFO - 'base_work_dir': '/builds/slave/test', 20:10:01 INFO - 'blob_upload_branch': 'Autoland', 20:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:10:01 INFO - 'branch': 'Autoland', 20:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:10:01 INFO - 'config_files': ('talos/mac_config.py',), 20:10:01 INFO - 'default_actions': ('clobber', 20:10:01 INFO - 'read-buildbot-config', 20:10:01 INFO - 'download-and-extract', 20:10:01 INFO - 'populate-webroot', 20:10:01 INFO - 'create-virtualenv', 20:10:01 INFO - 'install', 20:10:01 INFO - 'run-tests'), 20:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:10:01 INFO - 'download_minidump_stackwalk': True, 20:10:01 INFO - 'download_symbols': 'ondemand', 20:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:10:01 INFO - 'installer_path': 'installer.exe', 20:10:01 INFO - 'log_level': 'info', 20:10:01 INFO - 'log_name': 'talos', 20:10:01 INFO - 'log_to_console': True, 20:10:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:10:01 INFO - 'opt_config_files': (), 20:10:01 INFO - 'pip_index': False, 20:10:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:10:01 INFO - 'cmd': ('bash', 20:10:01 INFO - '-c', 20:10:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:10:01 INFO - 'enabled': True, 20:10:01 INFO - 'halt_on_failure': False, 20:10:01 INFO - 'name': 'check_screen_resolution'},), 20:10:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:10:01 INFO - 'cmd': ('bash', 20:10:01 INFO - '-c', 20:10:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:10:01 INFO - 'enabled': True, 20:10:01 INFO - 'halt_on_failure': False, 20:10:01 INFO - 'name': 'check_screen_resolution'},), 20:10:01 INFO - 'run_cmd_checks_enabled': True, 20:10:01 INFO - 'sps_profile': False, 20:10:01 INFO - 'sps_profile_interval': 0, 20:10:01 INFO - 'suite': 'dromaeojs-e10s', 20:10:01 INFO - 'system_bits': '32', 20:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:10:01 INFO - 'title': 't-yosemite-r7-0181', 20:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:10:01 INFO - 'use_talos_json': True, 20:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:10:01 INFO - 'work_dir': 'build'} 20:10:01 INFO - [mozharness: 2016-08-12 03:10:01.148909Z] Running clobber step. 20:10:01 INFO - Running pre-action listener: _resource_record_pre_action 20:10:01 INFO - Running main action method: clobber 20:10:01 INFO - rmtree: /builds/slave/test/build 20:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:10:03 INFO - Running post-action listener: _resource_record_post_action 20:10:03 INFO - [mozharness: 2016-08-12 03:10:03.235146Z] Finished clobber step (success) 20:10:03 INFO - [mozharness: 2016-08-12 03:10:03.235269Z] Running read-buildbot-config step. 20:10:03 INFO - Running pre-action listener: _resource_record_pre_action 20:10:03 INFO - Running main action method: read_buildbot_config 20:10:03 INFO - Using buildbot properties: 20:10:03 INFO - { 20:10:03 INFO - "project": "", 20:10:03 INFO - "product": "firefox", 20:10:03 INFO - "script_repo_revision": "production", 20:10:03 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 20:10:03 INFO - "repository": "", 20:10:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 20:10:03 INFO - "buildid": "20160811183317", 20:10:03 INFO - "pgo_build": "False", 20:10:03 INFO - "basedir": "/builds/slave/test", 20:10:03 INFO - "buildnumber": 111, 20:10:03 INFO - "slavename": "t-yosemite-r7-0181", 20:10:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 20:10:03 INFO - "platform": "yosemite_r7", 20:10:03 INFO - "scheduler": "tests-autoland-macosx64-talos", 20:10:03 INFO - "branch": "autoland", 20:10:03 INFO - "repo_path": "integration/autoland", 20:10:03 INFO - "revision": "ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a", 20:10:03 INFO - "stage_platform": "macosx64", 20:10:03 INFO - "builduid": "f5472141520f4406b8ba9cf0d7157895", 20:10:03 INFO - "slavebuilddir": "test" 20:10:03 INFO - } 20:10:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:10:03 INFO - Running post-action listener: _resource_record_post_action 20:10:03 INFO - [mozharness: 2016-08-12 03:10:03.238254Z] Finished read-buildbot-config step (success) 20:10:03 INFO - [mozharness: 2016-08-12 03:10:03.238354Z] Running download-and-extract step. 20:10:03 INFO - Running pre-action listener: _resource_record_pre_action 20:10:03 INFO - Running main action method: download_and_extract 20:10:03 INFO - mkdir: /builds/slave/test/build/tests 20:10:03 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')]} 20:10:03 INFO - trying https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:10:03 INFO - Downloading https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 20:10:04 INFO - Downloaded 1199 bytes. 20:10:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:10:04 INFO - Using the following test package requirements: 20:10:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:10:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:10:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:10:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'jsshell-mac.zip'], 20:10:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:10:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:10:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:10:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:10:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:10:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:10:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:10:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:04 INFO - trying https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:10:04 INFO - Downloading https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:10:05 INFO - Downloaded 16328612 bytes. 20:10:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 20:10:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:10:12 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')]} 20:10:12 INFO - trying https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:10:12 INFO - Downloading https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:10:12 INFO - Downloaded 16328612 bytes. 20:10:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 20:10:19 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')]} 20:10:19 INFO - trying https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:10:19 INFO - Downloading https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:10:20 INFO - Downloaded 14413719 bytes. 20:10:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 20:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:21 INFO - trying https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:10:21 INFO - Downloading https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 20:10:23 INFO - Downloaded 110970908 bytes. 20:10:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:10:23 INFO - mkdir: /builds/slave/test/properties 20:10:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:10:23 INFO - Writing to file /builds/slave/test/properties/build_url 20:10:23 INFO - Contents: 20:10:23 INFO - build_url:https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:10:24 INFO - Running post-action listener: _resource_record_post_action 20:10:24 INFO - Running post-action listener: set_extra_try_arguments 20:10:24 INFO - [mozharness: 2016-08-12 03:10:24.788362Z] Finished download-and-extract step (success) 20:10:24 INFO - [mozharness: 2016-08-12 03:10:24.788497Z] Running populate-webroot step. 20:10:24 INFO - Running pre-action listener: _resource_record_pre_action 20:10:24 INFO - Running main action method: populate_webroot 20:10:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:10:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:10:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:10:24 INFO - '--tppagecycles', 20:10:24 INFO - '7'], 20:10:24 INFO - 'tests': ['tsvgm']}}, 20:10:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:10:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:10:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:10:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:10:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:10:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['damp', 'tps']}, 20:10:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'tests': ['damp', 'tps']}, 20:10:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['dromaeo_dom']}, 20:10:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:10:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['basic_compositor_video']}, 20:10:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:10:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['a11yr', 20:10:24 INFO - 'ts_paint', 20:10:24 INFO - 'tpaint', 20:10:24 INFO - 'sessionrestore', 20:10:24 INFO - 'sessionrestore_no_auto_restore', 20:10:24 INFO - 'tabpaint']}, 20:10:24 INFO - 'other-e10s': {'tests': ['a11yr', 20:10:24 INFO - 'ts_paint', 20:10:24 INFO - 'tpaint', 20:10:24 INFO - 'sessionrestore', 20:10:24 INFO - 'sessionrestore_no_auto_restore', 20:10:24 INFO - 'tabpaint']}, 20:10:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:10:24 INFO - 'ts_paint', 20:10:24 INFO - 'tpaint', 20:10:24 INFO - 'sessionrestore', 20:10:24 INFO - 'sessionrestore_no_auto_restore', 20:10:24 INFO - 'tabpaint']}, 20:10:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:10:24 INFO - 'ts_paint', 20:10:24 INFO - 'tpaint', 20:10:24 INFO - 'sessionrestore', 20:10:24 INFO - 'sessionrestore_no_auto_restore', 20:10:24 INFO - 'tabpaint']}, 20:10:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['a11yr', 20:10:24 INFO - 'ts_paint', 20:10:24 INFO - 'tpaint', 20:10:24 INFO - 'sessionrestore', 20:10:24 INFO - 'sessionrestore_no_auto_restore', 20:10:24 INFO - 'tabpaint']}, 20:10:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['a11yr', 20:10:24 INFO - 'ts_paint', 20:10:24 INFO - 'tpaint', 20:10:24 INFO - 'sessionrestore', 20:10:24 INFO - 'sessionrestore_no_auto_restore', 20:10:24 INFO - 'tabpaint']}, 20:10:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['tsvgx', 20:10:24 INFO - 'tsvgr_opacity', 20:10:24 INFO - 'tart', 20:10:24 INFO - 'tscrollx', 20:10:24 INFO - 'cart']}, 20:10:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:10:24 INFO - 'tsvgr_opacity', 20:10:24 INFO - 'tart', 20:10:24 INFO - 'tscrollx', 20:10:24 INFO - 'cart']}, 20:10:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'talos_options': ['--disable-e10s'], 20:10:24 INFO - 'tests': ['tp5o']}, 20:10:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'tests': ['tp5o']}, 20:10:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'talos_options': ['--disable-e10s', 20:10:24 INFO - '--xperf_path', 20:10:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:24 INFO - 'tests': ['tp5n']}, 20:10:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:10:24 INFO - 'talos_options': ['--xperf_path', 20:10:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:10:24 INFO - 'tests': ['tp5n']}}, 20:10:24 INFO - 'talos.zip': {'path': '', 20:10:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:10:24 INFO - Running post-action listener: _resource_record_post_action 20:10:24 INFO - [mozharness: 2016-08-12 03:10:24.807072Z] Finished populate-webroot step (success) 20:10:24 INFO - [mozharness: 2016-08-12 03:10:24.807211Z] Running create-virtualenv step. 20:10:24 INFO - Running pre-action listener: _resource_record_pre_action 20:10:24 INFO - Running main action method: create_virtualenv 20:10:24 INFO - Creating virtualenv /builds/slave/test/build/venv 20:10:24 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 20:10:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:10:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:10:24 INFO - Using real prefix '/tools/python27' 20:10:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:10:25 INFO - Installing distribute.............................................................................................................................................................................................done. 20:10:28 INFO - Installing pip.................done. 20:10:28 INFO - Return code: 0 20:10:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:28 INFO - 'HOME': '/Users/cltbld', 20:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:28 INFO - 'LOGNAME': 'cltbld', 20:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:28 INFO - 'MOZ_NO_REMOTE': '1', 20:10:28 INFO - 'NO_EM_RESTART': '1', 20:10:28 INFO - 'PAGER': '/bin/cat', 20:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:28 INFO - 'PWD': '/builds/slave/test', 20:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:28 INFO - 'SHELL': '/bin/bash', 20:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:28 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:28 INFO - 'USER': 'cltbld', 20:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:28 INFO - 'XPC_FLAGS': '0x0', 20:10:28 INFO - 'XPC_SERVICE_NAME': '0', 20:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:28 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 20:10:28 INFO - Cleaning up... 20:10:28 INFO - Return code: 0 20:10:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:28 INFO - 'HOME': '/Users/cltbld', 20:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:28 INFO - 'LOGNAME': 'cltbld', 20:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:28 INFO - 'MOZ_NO_REMOTE': '1', 20:10:28 INFO - 'NO_EM_RESTART': '1', 20:10:28 INFO - 'PAGER': '/bin/cat', 20:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:28 INFO - 'PWD': '/builds/slave/test', 20:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:28 INFO - 'SHELL': '/bin/bash', 20:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:28 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:28 INFO - 'USER': 'cltbld', 20:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:28 INFO - 'XPC_FLAGS': '0x0', 20:10:28 INFO - 'XPC_SERVICE_NAME': '0', 20:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:29 INFO - Downloading/unpacking psutil>=3.1.1 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:32 INFO - Installing collected packages: psutil 20:10:32 INFO - Running setup.py install for psutil 20:10:32 INFO - building 'psutil._psutil_osx' extension 20:10:32 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 20:10:33 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 20:10:33 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 20:10:33 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 20:10:33 INFO - building 'psutil._psutil_posix' extension 20:10:33 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 20:10:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:10:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:10:33 INFO - ^ 20:10:33 INFO - 1 warning generated. 20:10:33 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 20:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:10:33 INFO - Successfully installed psutil 20:10:33 INFO - Cleaning up... 20:10:33 INFO - Return code: 0 20:10:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:33 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:33 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 20:10:33 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 20:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:33 INFO - 'HOME': '/Users/cltbld', 20:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:33 INFO - 'LOGNAME': 'cltbld', 20:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:33 INFO - 'MOZ_NO_REMOTE': '1', 20:10:33 INFO - 'NO_EM_RESTART': '1', 20:10:33 INFO - 'PAGER': '/bin/cat', 20:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:33 INFO - 'PWD': '/builds/slave/test', 20:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:33 INFO - 'SHELL': '/bin/bash', 20:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:33 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:33 INFO - 'USER': 'cltbld', 20:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:33 INFO - 'XPC_FLAGS': '0x0', 20:10:33 INFO - 'XPC_SERVICE_NAME': '0', 20:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10: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 20:10:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:10:36 INFO - Installing collected packages: mozsystemmonitor 20:10:36 INFO - Running setup.py install for mozsystemmonitor 20:10:36 INFO - Successfully installed mozsystemmonitor 20:10:36 INFO - Cleaning up... 20:10:36 INFO - Return code: 0 20:10:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:36 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:36 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 20:10:36 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 20:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:36 INFO - 'HOME': '/Users/cltbld', 20:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:36 INFO - 'LOGNAME': 'cltbld', 20:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:36 INFO - 'MOZ_NO_REMOTE': '1', 20:10:36 INFO - 'NO_EM_RESTART': '1', 20:10:36 INFO - 'PAGER': '/bin/cat', 20:10:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:36 INFO - 'PWD': '/builds/slave/test', 20:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:36 INFO - 'SHELL': '/bin/bash', 20:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:36 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:36 INFO - 'USER': 'cltbld', 20:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:36 INFO - 'XPC_FLAGS': '0x0', 20:10:36 INFO - 'XPC_SERVICE_NAME': '0', 20:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 20:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:10:39 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 20:10:39 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 20:10:39 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 20:10:39 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 20:10:39 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 20:10:39 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 20:10:39 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:39 INFO - warning: no files found matching '*.txt' 20:10:39 INFO - no previously-included directories found matching 'build' 20:10:39 INFO - no previously-included directories found matching 'dist' 20:10:39 INFO - no previously-included directories found matching '.git*' 20:10:39 INFO - Installing collected packages: jsonschema, functools32 20:10:39 INFO - Running setup.py install for functools32 20:10:40 INFO - warning: no files found matching '*.txt' 20:10:40 INFO - no previously-included directories found matching 'build' 20:10:40 INFO - no previously-included directories found matching 'dist' 20:10:40 INFO - no previously-included directories found matching '.git*' 20:10:40 INFO - Successfully installed jsonschema functools32 20:10:40 INFO - Cleaning up... 20:10:40 INFO - Return code: 0 20:10:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:10:40 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')]} 20:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:40 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')]} 20:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:40 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:40 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 20:10:40 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 20:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:40 INFO - 'HOME': '/Users/cltbld', 20:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:40 INFO - 'LOGNAME': 'cltbld', 20:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:40 INFO - 'MOZ_NO_REMOTE': '1', 20:10:40 INFO - 'NO_EM_RESTART': '1', 20:10:40 INFO - 'PAGER': '/bin/cat', 20:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:40 INFO - 'PWD': '/builds/slave/test', 20:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:40 INFO - 'SHELL': '/bin/bash', 20:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:40 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:40 INFO - 'USER': 'cltbld', 20:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:40 INFO - 'XPC_FLAGS': '0x0', 20:10:40 INFO - 'XPC_SERVICE_NAME': '0', 20:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:10:40 INFO - Cleaning up... 20:10:40 INFO - Return code: 0 20:10:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:10:40 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')]} 20:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:40 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')]} 20:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:40 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:40 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 20:10:40 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 20:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:40 INFO - 'HOME': '/Users/cltbld', 20:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:40 INFO - 'LOGNAME': 'cltbld', 20:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:40 INFO - 'MOZ_NO_REMOTE': '1', 20:10:40 INFO - 'NO_EM_RESTART': '1', 20:10:40 INFO - 'PAGER': '/bin/cat', 20:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:40 INFO - 'PWD': '/builds/slave/test', 20:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:40 INFO - 'SHELL': '/bin/bash', 20:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:40 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:40 INFO - 'USER': 'cltbld', 20:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:40 INFO - 'XPC_FLAGS': '0x0', 20:10:40 INFO - 'XPC_SERVICE_NAME': '0', 20:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:40 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:10:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:44 INFO - Downloading docopt-0.6.1.tar.gz 20:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 20:10:44 INFO - Running setup.py install for blobuploader 20:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:10:44 INFO - Running setup.py install for requests 20:10:45 INFO - Running setup.py install for docopt 20:10:45 INFO - Successfully installed blobuploader requests docopt 20:10:45 INFO - Cleaning up... 20:10:45 INFO - Return code: 0 20:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:45 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:45 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 20:10:45 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 20:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:45 INFO - 'HOME': '/Users/cltbld', 20:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:45 INFO - 'LOGNAME': 'cltbld', 20:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:45 INFO - 'MOZ_NO_REMOTE': '1', 20:10:45 INFO - 'NO_EM_RESTART': '1', 20:10:45 INFO - 'PAGER': '/bin/cat', 20:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:45 INFO - 'PWD': '/builds/slave/test', 20:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:45 INFO - 'SHELL': '/bin/bash', 20:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:45 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:45 INFO - 'USER': 'cltbld', 20:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:45 INFO - 'XPC_FLAGS': '0x0', 20:10:45 INFO - 'XPC_SERVICE_NAME': '0', 20:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-EvLZBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-vX8R6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-EVoTjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-nqMsNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-14JYcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-C3mGae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-_X1WSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-rnsdAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Zxe0ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-pajBgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-56YRHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-68nqN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-_mJT6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:47 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-6QibAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:47 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-VDEqG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:47 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-HFL2BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:47 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-tMIitH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:10:47 INFO - Running setup.py install for manifestparser 20:10:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:10:47 INFO - Running setup.py install for mozcrash 20:10:47 INFO - Running setup.py install for mozdebug 20:10:47 INFO - Running setup.py install for mozdevice 20:10:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Running setup.py install for mozfile 20:10:48 INFO - Running setup.py install for mozhttpd 20:10:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Running setup.py install for mozinfo 20:10:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Running setup.py install for mozInstall 20:10:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Running setup.py install for mozleak 20:10:48 INFO - Running setup.py install for mozlog 20:10:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:10:48 INFO - Running setup.py install for moznetwork 20:10:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:10:49 INFO - Running setup.py install for mozprocess 20:10:49 INFO - Running setup.py install for mozprofile 20:10:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:10:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:10:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:10:49 INFO - Running setup.py install for mozrunner 20:10:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:10:49 INFO - Running setup.py install for mozscreenshot 20:10:49 INFO - Running setup.py install for moztest 20:10:49 INFO - Running setup.py install for mozversion 20:10:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:10:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:10:49 INFO - Cleaning up... 20:10:49 INFO - Return code: 0 20:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:49 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')]} 20:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:49 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')]} 20:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:49 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:49 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 20:10:49 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 20:10:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:49 INFO - 'HOME': '/Users/cltbld', 20:10:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:49 INFO - 'LOGNAME': 'cltbld', 20:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:49 INFO - 'MOZ_NO_REMOTE': '1', 20:10:49 INFO - 'NO_EM_RESTART': '1', 20:10:49 INFO - 'PAGER': '/bin/cat', 20:10:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:49 INFO - 'PWD': '/builds/slave/test', 20:10:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:49 INFO - 'SHELL': '/bin/bash', 20:10:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:49 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:49 INFO - 'USER': 'cltbld', 20:10:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:49 INFO - 'XPC_FLAGS': '0x0', 20:10:49 INFO - 'XPC_SERVICE_NAME': '0', 20:10:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Y8mEYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qlCbQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ROYYhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-vhgAKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-9TyDDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qarzDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-lHRg5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:50 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)) 20:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-DYfU6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-n8edPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-FyhamO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-YoIzNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-s_MUuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Xzgo8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-fNZ89P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-d00oEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-xWN5XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:51 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)) 20:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LXLiRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:52 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)) 20:10:52 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)) 20:10:52 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)) 20:10:52 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)) 20:10:52 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)) 20:10:52 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)) 20:10:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:10:52 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 20:10:52 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 20:10:52 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 20:10:52 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 20:10:52 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 20:10:52 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 20:10:54 INFO - Downloading blessings-1.6.tar.gz 20:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:54 INFO - Installing collected packages: blessings 20:10:54 INFO - Running setup.py install for blessings 20:10:54 INFO - Successfully installed blessings 20:10:54 INFO - Cleaning up... 20:10:54 INFO - Return code: 0 20:10:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:55 INFO - Reading from file tmpfile_stdout 20:10:55 INFO - Current package versions: 20:10:55 INFO - blessings == 1.6 20:10:55 INFO - blobuploader == 1.2.4 20:10:55 INFO - docopt == 0.6.1 20:10:55 INFO - functools32 == 3.2.3-2 20:10:55 INFO - jsonschema == 2.5.1 20:10:55 INFO - manifestparser == 1.1 20:10:55 INFO - mozInstall == 1.12 20:10:55 INFO - mozcrash == 0.17 20:10:55 INFO - mozdebug == 0.1 20:10:55 INFO - mozdevice == 0.48 20:10:55 INFO - mozfile == 1.2 20:10:55 INFO - mozhttpd == 0.7 20:10:55 INFO - mozinfo == 0.9 20:10:55 INFO - mozleak == 0.1 20:10:55 INFO - mozlog == 3.3 20:10:55 INFO - moznetwork == 0.27 20:10:55 INFO - mozprocess == 0.23 20:10:55 INFO - mozprofile == 0.28 20:10:55 INFO - mozrunner == 6.12 20:10:55 INFO - mozscreenshot == 0.1 20:10:55 INFO - mozsystemmonitor == 0.3 20:10:55 INFO - moztest == 0.7 20:10:55 INFO - mozversion == 1.4 20:10:55 INFO - psutil == 3.1.1 20:10:55 INFO - requests == 1.2.3 20:10:55 INFO - wsgiref == 0.1.2 20:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:55 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')]} 20:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:55 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')]} 20:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:55 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:55 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 20:10:55 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 20:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:55 INFO - 'HOME': '/Users/cltbld', 20:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:55 INFO - 'LOGNAME': 'cltbld', 20:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:55 INFO - 'MOZ_NO_REMOTE': '1', 20:10:55 INFO - 'NO_EM_RESTART': '1', 20:10:55 INFO - 'PAGER': '/bin/cat', 20:10:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:55 INFO - 'PWD': '/builds/slave/test', 20:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:55 INFO - 'SHELL': '/bin/bash', 20:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:55 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:55 INFO - 'USER': 'cltbld', 20:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:55 INFO - 'XPC_FLAGS': '0x0', 20:10:55 INFO - 'XPC_SERVICE_NAME': '0', 20:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 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)) 20:10:56 INFO - Cleaning up... 20:10:56 INFO - Return code: 0 20:10:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:56 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 0x103435a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034ca618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1e0d70380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, '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.fwEmdslo7s/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.c5i4fMZorw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:10:56 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 20:10:56 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 20:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:56 INFO - 'HOME': '/Users/cltbld', 20:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:56 INFO - 'LOGNAME': 'cltbld', 20:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:56 INFO - 'MOZ_NO_REMOTE': '1', 20:10:56 INFO - 'NO_EM_RESTART': '1', 20:10:56 INFO - 'PAGER': '/bin/cat', 20:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:56 INFO - 'PWD': '/builds/slave/test', 20:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:56 INFO - 'SHELL': '/bin/bash', 20:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:10:56 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:56 INFO - 'USER': 'cltbld', 20:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:56 INFO - 'XPC_FLAGS': '0x0', 20:10:56 INFO - 'XPC_SERVICE_NAME': '0', 20:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:10:56 INFO - Cleaning up... 20:10:56 INFO - Return code: 0 20:10:56 INFO - Running post-action listener: _resource_record_post_action 20:10:56 INFO - Running post-action listener: _start_resource_monitoring 20:10:56 INFO - Starting resource monitoring. 20:10:56 INFO - [mozharness: 2016-08-12 03:10:56.419932Z] Finished create-virtualenv step (success) 20:10:56 INFO - [mozharness: 2016-08-12 03:10:56.420961Z] Running install step. 20:10:56 INFO - Running pre-action listener: _resource_record_pre_action 20:10:56 INFO - Running main action method: install 20:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:56 INFO - Reading from file tmpfile_stdout 20:10:56 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:10:56 INFO - Reading from file tmpfile_stdout 20:10:56 INFO - Output received: 20:10:56 INFO - Usage: mozinstall [options] installer 20:10:56 INFO - Options: 20:10:56 INFO - -h, --help show this help message and exit 20:10:56 INFO - -d DEST, --destination=DEST 20:10:56 INFO - Directory to install application into. [default: 20:10:56 INFO - "/builds/slave/test"] 20:10:56 INFO - --app=APP Application being installed. [default: firefox] 20:10:56 INFO - mkdir: /builds/slave/test/build/application 20:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:11:30 INFO - Reading from file tmpfile_stdout 20:11:30 INFO - Output received: 20:11:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:11:30 INFO - Running post-action listener: _resource_record_post_action 20:11:30 INFO - [mozharness: 2016-08-12 03:11:30.757998Z] Finished install step (success) 20:11:30 INFO - [mozharness: 2016-08-12 03:11:30.758174Z] Running run-tests step. 20:11:30 INFO - Running pre-action listener: _resource_record_pre_action 20:11:30 INFO - Running main action method: run_tests 20:11:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:11:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:11:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:11:30 INFO - 2016-08-11 20:11:30.772 screenresolution[1650:7740] starting screenresolution argv=screenresolution get 20:11:30 INFO - 2016-08-11 20:11:30.775 screenresolution[1650:7740] Display 0: 1600x1200x32@60 20:11:30 INFO - 2016-08-11 20:11:30.782 screenresolution[1651:7748] starting screenresolution argv=screenresolution list 20:11:30 INFO - Available Modes on Display 0 20:11:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:11:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:11:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:11:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:11:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:11:31 INFO - Intel Iris: 20:11:31 INFO - Chipset Model: Intel Iris 20:11:31 INFO - Type: GPU 20:11:31 INFO - Bus: Built-In 20:11:31 INFO - VRAM (Dynamic, Max): 1536 MB 20:11:31 INFO - Vendor: Intel (0x8086) 20:11:31 INFO - Device ID: 0x0a2e 20:11:31 INFO - Revision ID: 0x0009 20:11:31 INFO - Displays: 20:11:31 INFO - Display: 20:11:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:11:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:11:31 INFO - Display Serial Number: 1600x1200 60 20:11:31 INFO - Main Display: Yes 20:11:31 INFO - Mirror: Off 20:11:31 INFO - Online: Yes 20:11:31 INFO - Rotation: Supported 20:11:31 INFO - Return code: 0 20:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:11:31 INFO - Python 2.7.3 20:11:31 INFO - Return code: 0 20:11:31 INFO - grabbing minidump binary from tooltool 20:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:11:31 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 0x103399d30>, '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 0x1030fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103391b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:11:31 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 20:11:31 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 20:11:31 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 20:11:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:11:31 INFO - Return code: 0 20:11:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:11:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:11:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:11:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:11:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fwEmdslo7s/Render', 20:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:11:31 INFO - 'HOME': '/Users/cltbld', 20:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:11:31 INFO - 'LOGNAME': 'cltbld', 20:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:11:31 INFO - 'MOZ_NO_REMOTE': '1', 20:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:11:31 INFO - 'NO_EM_RESTART': '1', 20:11:31 INFO - 'PAGER': '/bin/cat', 20:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:11:31 INFO - 'PWD': '/builds/slave/test', 20:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:11:31 INFO - 'SHELL': '/bin/bash', 20:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c5i4fMZorw/Listeners', 20:11:31 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:11:31 INFO - 'USER': 'cltbld', 20:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:11:31 INFO - 'XPC_FLAGS': '0x0', 20:11:31 INFO - 'XPC_SERVICE_NAME': '0', 20:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:11:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:11:31 INFO - mozversion application_buildid: 20160811183317 20:11:31 INFO - mozversion application_changeset: ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a 20:11:31 INFO - mozversion application_display_name: Nightly 20:11:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:11:31 INFO - mozversion application_name: Firefox 20:11:31 INFO - mozversion application_remotingname: firefox 20:11:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:11:31 INFO - mozversion application_vendor: Mozilla 20:11:31 INFO - mozversion application_version: 51.0a1 20:11:31 INFO - mozversion platform_buildid: 20160811183317 20:11:31 INFO - mozversion platform_changeset: ebbebe3e2aeed6fc6434ae7c4b7c9b9460b0c93a 20:11:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:11:31 INFO - mozversion platform_version: 51.0a1 20:11:31 INFO - using testdate: 1470971491 20:11:31 INFO - actual date: 1470971491 20:11:31 INFO - starting webserver on 'localhost:49270' 20:11:31 INFO - SUITE-START | Running 2 tests 20:11:31 INFO - TEST-START | dromaeo_css 20:11:31 INFO - operating with platform_type : mac_ 20:11:31 INFO - Initialising browser for dromaeo_css test... 20:11:31 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpD6Q7SN/profile http://localhost:49270/getInfo.html) 20:11:34 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 20:11:34 INFO - PROCESS | 1661 | colorDepth:24 20:11:34 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 20:11:34 INFO - PROCESS | 1661 | __metrics 20:11:34 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:11:34 INFO - TEST-INFO | 1661: exit 0 20:11:34 INFO - Browser initialized. 20:11:34 INFO - Running cycle 1/1 for dromaeo_css test... 20:11:34 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpD6Q7SN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:46 INFO - PROCESS | 1664 | RSS: Main: 254681088 20:11:46 INFO - PROCESS | 1664 | 20:12:36 INFO - PROCESS | 1664 | 1470971556412 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] 20:14:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 20:14:49 INFO - PROCESS | 1664 | RSS: Main: 267698176 20:14:49 INFO - PROCESS | 1664 | 20:17:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 20:17:52 INFO - PROCESS | 1664 | RSS: Main: 277221376 20:17:52 INFO - PROCESS | 1664 | 20:20:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 20:20:55 INFO - PROCESS | 1664 | RSS: Main: 282202112 20:20:55 INFO - PROCESS | 1664 | 20:23:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 20:23:57 INFO - PROCESS | 1664 | RSS: Main: 280690688 20:23:57 INFO - PROCESS | 1664 | 20:27:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 20:27:01 INFO - PROCESS | 1664 | RSS: Main: 285003776 20:27:01 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 20:30:04 INFO - PROCESS | 1664 | RSS: Main: 286760960 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | __start_tp_report 20:30:04 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 20:30:04 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 20:30:04 INFO - PROCESS | 1664 | |i|pagename|runs| 20:30:04 INFO - PROCESS | 1664 | |0;dojo.html;3133.310671652236;3373.1398493384168;3400.200952776097;3411.3006833599115;3423.1955490459745;5515.917261241075;5591.273134492515;5618.2415373924505;5650.293713285834;5708.372079071299;5503.862403439906;5554.583406244537;5570.470805273502;5597.356304025038;5715.571332150084;5020.97489512552;5127.615428842833;5188.221766734982;5216.973915130419;5224.8693782655355;4999.500049995007;5025.3718285214345;5136.049830781299;5180.067587834188;5240.60695447841;5063.74681265937;5106.285120083191;5123.487651234866;5128.71792051437;5150.613703972217;5090.160123579605;5102.132637451605;5134.332536770234;5147.794088236466;5190.325257716473;4854.417469903634;5040.823571175028;5067.265246539231;5118.488151184889;5129.410117836459;5478.671279723189;5623.409541998072;5645.830625081254;5658.7170641467765;5724.79963201286;4543.34121552373;6166.814995550096;6184.474319682832;6201.596896201732;6225.408586184305;6052.061930400795;6103.664298463583;6217.658028808413;6260.968695156541;6264.060390941349;5665.320161580596;5741.88516229673;5767;5784.421557844182;5804.564657650609;6171.660558669317;6188.845278867974;6237.033259844731;6243.687815609202;6248.31268560458;5469.659933316363;5897.557683173779;6079.088136779518;6086.360932102154;6097.512199024068;5672.773089076473;6151.507879369639;6179.567430279837;6190.845228869314;6210.658413787285;5423.240746295522;5743.712814359265;6127.234095738033;6153.446189842935;6157.230346206724;4569.817207311737;5933.258342707161;5969.194158788595;6082.2093127893095;6179.5056395488255;3804.904877378088;4116.217918595457;4887.193613053877;4895.559399654048;5137.075326441276;3878.4957955466175;4386.2762644163995;4402.625776808943;4410.6030457259;4438.090191510732;5571.387147413781;5664;5677.744501497443;5717.256756621613;5729.627574207663;6089.360617135226;6089.48239399656;6120.510359171256;6165.414285642857;6178.62928224299;5648.124540696199;5661.46216109469;5709.915116127922;5714.257146570919;5722.11307247369;4640.466346370143;5245.475452454801;5362.91955620666;5370.516653501204;5374.731263436813;6121.300552271563;6144.126041557368;6167.475764560063;6235.75056997715;6238.75044998195;6161.291451483136;6167.1366008759705;6167.444929956326;6171.413715697002;6204.937950620436;6084.452399284086;6163.907541386972;6236.781712640036;6249.218847644044;6252.468540174136;6000.249968753906;6014.278286605635;6044.788432404845;6111.98679349419;6121.632702037892;5136.998285334324;6089.299730530868;6135.98756205239;6153;6161.938380616137;5819.330776960704;5856.180134781219;6072.574919755752;6080.90878636812;6090.3605121461605;5931.673757943355;6010.939890601038;6046.09308603713;6054.848628784315;6092.634441933498;5513.724313784375;5699.458551437607;5842.591018628656;5902.38025007368;5943.465088142088;5838.2702162229725;6017.458428741259;6055.424734650202;6059.424354686298;6084.756609735561;5799.043157878903;5866.2960444746905;5869.794557190648;5948.464638182411;6004.789832355847 20:30:04 INFO - PROCESS | 1664 | |1;ext.html;520.2690220240562;529.6133822309713;535.085004642062;537.9300690910181;571.3372487914015;30535.083947481555;40875.79562102189;41004.38493422601;41024.58975410249;41057.38413923793;42204.788976055155;42802.78598607011;42864.57135428645;42919.14161716764;42965;9611.279154063439;9819.558119884623;9830.410175389463;9834.26243031772;9838.754031149207;9642.180414664763;9751.707448776548;9754;9766.804663906718;9770.658026969057;9736.123748862601;9785.021497850194;9793.706188814347;9799.510024498783;9804.950975245149;9724.756881077994;9733.805323893517;9769.609215631366;9787.608495660237;9795.02049795022;9704.854427183598;9761.853572196424;9768.21854251658;9782.51087445625;9788.412695238309;40010;40093.79953100216;40267;40353.39469907954;40420.79789601063;3092.969070309313;3499.9650003500146;3528.541289632357;3616.0055984604446;4118.670506359514;31704.841475792706;32506.837465812758;32597.185070373194;32870.506942395885;32985.67014329874;2774.902878399246;3215.8713651453913;3250.7724459287624;3271.313024264907;3345.280764635591;492266;495213;496006;497259;498454.5077274627;61471.69264153651;61563.6921815397;61877.69061154756;62079;62352.376476235564;34927;56985;61168.08247876285;65286.673566631864;65544.34455655477;15936.601584960468;16623;16789.16054197285;16796.58008549796;16830;12414;12416.75166496665;12475.750484990249;12486.687832804253;12499.3750312484;18427.170777315052;18759.718604220947;19496.009953878263;19855.106520206624;19896.60206795856;8179.222973817477;8377.287930525974;8383.664653413794;8394.664213431395;8521.786955326043;733.9266073392724;792.8464084756665;904.3127223310331;929.8419268724333;949.3402085550614;30034.549481757793;30424.69575304263;30601.846990764905;31368.37263254768;31394.901178458644;946.2997381937455;959.6497278493439;1046.0689985912543;1066.0405634928627;1216.7262365967763;13311.73376532464;14135.869130469539;16093.597660058358;16136.112513811853;16474;650390;694344.056559438;694781;695895.5205223941;699505;59461.10808337792;60048;60202.39797601968;60233.09650355248;60427.09359359613;1240.8324876141785;1321.6365499487526;1342.033735710287;1396.8533304003136;1405.5361730628663;29767.80928762912;30399.54400683947;30636.84681576667;30687.2328191797;30930.76276948987;52683.73658131685;52901.470985289656;53162.46837531575;53181.46818531765;53201.4679853212;450035;591909.0404548122;593130;595706;598222;27210;27236.591451127853;27565.448691025667;27853.16440506788;27960.44079118447;48932.755336224516;49590;49861.501384985684;49957.75021124871;50102.74948625379;38299.61700383072;40377.596224037385;40834;41253.793731032354;41836.79081604572;40288;40412.79793601013;40436;40616.79691601523;41729.1654166921;34154.14614634654;38287.04282392962;38360.616393835706;39100.63147789814;39172.80413597914;35242.82378588091;35598.11004724903;36038.91883243507;36079.81960090183;36269.27461450809;22506.66240006434;24404.75595244025;26236.606450903633;26306.34234144085;26331.473370532865 20:30:04 INFO - PROCESS | 1664 | |2;jquery.html;329.53535514923954;370.17451084082495;375.8552957111512;384.5942530630184;395.0223197585975;19881.900590497044;20282.492937676547;20709;20841.374758757225;21147.47131321718;20368.287109951154;20511.897440512777;20665.380038598865;20835.27076552317;21059.789402105973;5040.319556859814;5393.892122157555;5671.177679236508;6133.785317513888;6212.347703491136;3994.0613955720382;5917.112433135021;6078.240219972504;6217;6236.6258024518675;6060.181875446824;6230.25236971564;6236.875262494747;6252.687365631723;6253.6873156342;6754.66226688666;6866.416354609839;6867.656617169122;6881.380675739158;6886.931130688704;5089.236614507853;5350.384705758848;5442.210879422461;6016.578839481238;6050.788222412239;13327.200367977952;13351.265680387574;13472.056956013083;13558.593242202749;13624.318784060757;2088.631946075323;2117.8093971542635;2133.4453042208984;2178.6405243134864;2269.6595510673365;10123.797524049478;10575.471226438647;10687.572497100107;12325.568605098868;15074.397024119022;1880.8401285890716;1894.3180455036177;1900.6673832079468;1934.1103092577432;1951.590166065128;106890.46554767255;107695;118894.68633801186;127716;129208;11422.543098275975;11448.713782155346;11538.480768365444;11706.941465292619;11902.988245999188;14425.92787036079;14432.639184020483;14460;14463.349149288308;14492.98549101574;8044.959775201087;8176.836463270702;8319.542425166674;8487.872681909776;8644.178803013703;7132.964335178394;8402.873956890651;8442.929046923196;8457.873131903027;8630.870536941951;4509.120721459284;4554.4990051094355;4571.2000399929875;4602.88492787683;4671.11248862715;1590.6023494126468;1927.9492676491345;3182.98408507956;3652.6164752700583;3707.480952666629;869.826034793044;877.4866702978701;885.6900084970338;939.9530023498797;1008.5209525475487;19366.903165484084;21119;21423.785762142492;21959.67060494094;22028.89855507218;929.3504030346055;950.5199874063553;964.508100868548;978.3933960944261;1047.7537778622018;8729.956350218208;9459.24326053914;11198;11374.976252137347;11449.828252576219;595914;599478;617884;628027;639671;80716;140874;150929;151857.72213416809;155612.88774224452;422.56053704147956;442.4027562790272;444.9911001779946;445.125328729049;445.3364486914539;10491.895081049091;10954.287971281841;11668.70828229301;11827.881721182677;11832.645020649394;32392.310537523033;56951.715241423524;58210.70894645499;58265;58957;76086.8586971207;78411.60794195993;79558.80661790194;80484.59757701174;83956.16043839483;5615.438456154516;5964.493018093337;7759.486900054435;8081.515109093473;8642;11474.541018359507;12560.937195313965;12813.295268760308;13030.804537932128;13288.601341959757;10675.583813179708;11406.201565890307;11412.429378530875;11456.255343402652;11539.480723367637;8918.777030574287;9951.104400603981;10022.298439109192;10401.635942741968;11425.942870285595;9984.35101718386;11125.610603628835;11244.381559014333;11648.592299269485;11708.297502149899;8053.355731541345;8175.427720059776;8287.58562071906;8297.917020829715;8422.91577084246;8224.794380140544;10921.508532116233;11343.546258149581;11417.0866330695;11421.714457138638 20:30:04 INFO - PROCESS | 1664 | |3;mootools.html;1448.1094127111826;1522.9643842187309;1690.8900921440106;1809.3938530592243;1825.71701386285;7835.412344074203;8471.407001509897;8572.142785721424;8975.326850486215;9017.323700722447;7684.615769211545;8531.530765807893;8593.828123437528;8756.91243087569;8760.649574017032;2126.5002724359765;2290.7365652949957;2317.1079134533156;2346.9765302347014;2349.659299401586;1989.4827344890289;2227.7969896256004;2329.650552417134;2339.7426283108844;2344.097522453859;2322.071171531384;2325.802306803924;2329.1731435340466;2337.2287145242112;2351.9176828810996;2298.747137814839;2300.3903965449167;2318.93043208704;2327.6159433693506;2329.871857047862;2295.2655150351893;2298.609236429811;2302.4589221533092;2307.6653885186556;2309.549637820626;8818;8833.734987950373;8857.822843543157;8871.512066836322;8878;5116.565091967187;5330.360356757175;5332.066888294533;5347.491988261109;5358.758855851496;3322.2026713588807;3477.4609935460044;3511.438169892805;3566.465030245458;3626.057225121461;1077.7036315013356;1083.496174278964;1083.7615724540667;1087.4508373271526;1107.1143085531623;11763.411829408495;11857.5849845255;11952.940235298855;11980.700482488008;11990.040796736328;4524.886877828015;4678.064387122521;4777.904441911142;4779.856604301876;4796.208625576741;9863.852042219372;9966.551505182284;10000.549975250986;10017.398956062514;10046.547905344278;5308.46915308466;5316.548093412026;5316.6544174628525;5336.866578335573;5358.866028349323;4316.762578058237;4603.5396460353695;4820.180569303227;4872.1717308057005;4875;3866.284737323604;3891.3968334908136;3991.16185601027;4016.819243134066;4029.838806447768;1254.861965183829;1262.8800263974908;1268.9428975696117;1270.7140893299118;1274.241826113461;792.984140317202;813.5281536708695;844.923956843887;905.1401168889581;941.9811603767886;5735.627184233012;5773;5800.332961709458;5977.193078934375;6099.176611157525;735.9926400735924;952.5094576293214;955.9675550405545;965.560669895196;969.6266937229218;3312.602487701443;3353.7652364334263;3911.706622003361;4009.2182024505523;4072.3891416287793;9568.952155239318;10412;10795.78408431827;10798.460076996118;10826;10757.569697212024;10811.351318920733;10829.24195306321;10867.619633312795;10885.727856803485;7709.4603377763015;7944.682212711542;8137.552434616153;8137.901383313177;8290.917090829134;5916.053431450947;5927;5955.583109182316;6026.698665066817;6039.456448919618;9700.6119755209;9880.35777674449;9888.011198880055;9937.304388692723;9965.900340996497;9781.951090244504;10117.494125293559;10236.976302369703;10246.333988291035;10276.383416995004;6795.626240556817;7389.334959853639;7554.093508778982;7566.583837888748;7649.923500764921;8380.874286885579;8386.245237928615;8416.873746893923;8507.234348908629;8563.785905352415;7482.476226664081;7657.61747593991;7663.348615367756;7721.7683469496005;7744.380449563909;7381;7417.332440080419;7449.515781474187;7549.433792465697;7585;6975.407090397373;7059;7090.468214883801;7106.786796396116;7116.573005619679;4634.536546345474;4661.3707149534375;4884.853454396374;5048.864005598858;5050.74746262678;4948.233023881304;4950.975245123751;5082.161443361804;5113.795448182031;5205.375354957429 20:30:04 INFO - PROCESS | 1664 | |4;prototype.html;296.3716920129326;308.22635185683936;312.58738465225906;315.94474455319227;316.09754151896334;4267.335739061768;4662.020975595129;5394.298741163648;5530.866172434651;5560.304961879765;5316.574674026078;5474.39781624021;5552.583556233279;5556.194351818984;5619.297587801525;3508.7894726316504;3903.8438462461468;4240.575942405758;4251.489821221442;4256.936145957813;3951.5258169019758;4176.076746277603;4240.363945408198;4256.701705979691;4268.338407546819;3376.51040599113;4134.235166494208;4144.155850646448;4156.750594964296;4158.272302347093;3603.5495563054487;4152.110789590729;4165.97917010413;4172.207280616703;4180.143070670505;3313.2213929726495;3611.8735844245325;3618.6019537850816;3634.800085995269;3636.981815090934;4267.658587313008;4751.524847515256;5442.564594832404;5452.536534394581;5460.126379779256;3581.910452238689;3935.9569714025806;4232.343986682069;4636.884077898079;4769.284607308897;4539.4779600346055;5076.898462030776;5577.745007373349;5839.124131380327;5897.705114744245;3366.797992120456;3833.195029043904;3934.4688467056867;3956.8021598920227;3987.7300613496946;6115.523213098702;6138.47822935051;6142.907856382158;6152.261728592597;6191.597546159485;3548.509625957104;4007.939880901789;4011.91976160481;4018.6383225509844;4029.315016447211;3734.6078661740125;3931.4495970564144;4003.619656132663;4056.472658554369;4102.91794164121;4701.294805779092;4734.526547345238;4735.934414756721;4749.1926372516755;4765.332853400527;5663.575231857627;5879.470847623649;5901.29184497863;5906.763729450774;5934.139549765347;1154.549725607014;1291.509226493945;1294.7475242327844;1316.7037416581193;1354.94991381678;904.9321800275607;907.677774390082;923.9307051970994;935.354605322339;937.1097457415483;4901.43633482147;5379.704116273564;5417.724555686542;5428.67427954324;5505.366882808448;5555.999920014356;5634.1830434586755;5951.761929522857;6007.579469437185;6051.667158306335;4826.696791866177;5138.409082955508;5228.503292187236;5251.238570407269;5492.286002819608;2157.64398874184;2567.0245306783304;2658.5469338857724;2678.3304173956512;2681.016048124374;4757.643176761757;5107.31458618655;5229.450907654642;5265.8146869048915;5306.62853600252;4426.513083560806;4698.8120475181295;4763.69036012658;5104.719240441737;5197.58419326453;4405.625521830681;4561.635069194523;5242.842714718565;5271.393789714155;5304.310439642899;4329.8051587678;4427.867163985085;4532.818687252473;4798.904021919472;4927.655064145475;4921.4497433309825;4980.729913871939;5372.5701943843615;5999.880002400015;6029.306629737636;6313.337099604659;6336.683165841598;6364.681765911779;6374.298827129105;6406.391392817675;4018.618231268025;4037.031112532912;4046.676265898662;4047.3928910662457;4079.103217004107;4959.156943319716;5341.465853414627;5417.268668729671;5514.28314319152;5591.552675785846;4910.656254062182;5254.238135470259;5701.971490142523;5856.502197313276;5939.703014849154;5253.973730131325;5390;5649.096144616841;5924.7926322578505;5930.991731405585;5235.528802407802;5363.973180134074;5713.8285851424525;5844.8310337933435;5885.823425297248;4679.368285281444;5192.922106168486;5287.471252874681;5959.67221802805;5966.164736936919;5616.170612830729;5787.913181302368;5823.806119745357;5849.912251316148;5855.94144058554 20:30:04 INFO - PROCESS | 1664 | |5;yui.html;701.424831638057;716.9820754481141;720.4128635162342;764.3273918951322;867.4535042922957;13995.860041399583;15255.47445255474;15289.923550382246;15968.600784980366;16134.112623805686;13998.720025599507;14553.345099470524;14579.562613121623;14646.853531464709;14692.779608305884;845.5941148248844;866.2117473099481;867.5835598912525;870.2037635563452;872.7774417523523;689.2108535726616;825.2861274997144;845.7589586967715;856.6958729650978;857.5540718826238;900.1403659505189;909.5679552212712;909.6997990663066;910.0308171797049;910.2263076385086;879.160401816264;901.3555307954779;904.1726819959729;904.3443503460005;904.9999750275949;654.6039646014141;665.5174998126369;668.6021817018866;675.5912672832915;676.8510927595921;15147.394104235816;15199.544013679608;15205.619859503491;15207.695846083016;15232.771508427382;14757.557273281818;14798.852011479963;14817.851821481754;14878.330475128645;15123.621909452242;10292.330998485075;10442.843357349646;11008.669739907735;11909.166358354918;11935.343556104412;3540.7521473496868;3793.715471339661;3866.9226615467815;3917.3536366499493;4059.0867054912705;122971;125067.74932250743;126659;128164;128265.35867320604;11459.369734664508;11568.074554035657;11576.189666723249;11633.243839150427;11752.88247117535;20045;20203.898980505004;23871;23935.16226932049;24001.27996160118;7524.946507488956;7635.198304177981;7674.96162519195;7756.146823849372;7837.804054898673;4605.309203619417;4655.4180727409075;4665.790039448233;4680.134175177603;4792.017636384533;3665.633436656313;3743.082944678571;3757.755745876509;3793.2223894101644;3794.4118661607495;642.0113025940093;647.1716203259834;651.8533330000712;654.3979538824293;655.226832337846;532.1645017322843;661.4057843302269;672.6244829324044;682.8190529509684;691.95860230354;9279.582418791035;9357.812843743088;9412.341136120405;9493.477858717837;9793.216542676711;644.5198327246231;657.710607332772;658.6607896933083;669.5848573884223;682.3585829320423;4424.00721392165;4485.618722408566;4653.022865198346;4673.929891051637;4724.858254252378;99154.50422747985;99711.00288997017;107078.3938240927;165460;174433;134976;135328;136259.31870340585;137333;137636.5748936575;79070.20929790744;79806.99999999884;118907;121435.39282303886;121752;8991.325650576102;9017.128062138912;9052.456852588866;9063.546822658709;9124.817503650023;68048;69399.44804415533;69747.65126174336;69764.65117674379;70024.64987675233;104731;105738.47130764298;108142.45928770621;108650.45674771891;109174;11816.350100744541;12189.75620487603;12214.938925305316;12240.938795305967;12420.937895310826;13015.869841301466;13133.212007279593;13393.464261429433;13446.731065378443;13967.056106169171;12517.56188533397;12620.432080556213;12673.873261267638;12851.357432128543;12854.228746275254;12173.57392491294;12404.689882753004;12445.75108497843;12776.10567260283;12813.679658008625;10652;12280.754384912074;12509.874901251234;12529.248245105322;12556.309402982924;10606.628767993083;10653.573857045942;10840.267547875703;10871.456427178768;11559.017483513659;8465.788355291166;8637.56812159402;9450.574724137292;10695.197860160364;10754.462276885968 20:30:04 INFO - PROCESS | 1664 | __end_tp_report 20:30:04 INFO - PROCESS | 1664 | __start_cc_report 20:30:04 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,414 20:30:04 INFO - PROCESS | 1664 | __end_cc_report 20:30:04 INFO - PROCESS | 1664 | __startTimestamp1470972604581__endTimestamp 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | ------- Summary: start ------- 20:30:04 INFO - PROCESS | 1664 | Number of tests: 6 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5613.34 Median:5784.42 stddev:661.74 (11.4%) stddev-sans-first:634.53 20:30:04 INFO - PROCESS | 1664 | Values: 3133.3 3373.1 3400.2 3411.3 3423.2 5515.9 5591.3 5618.2 5650.3 5708.4 5503.9 5554.6 5570.5 5597.4 5715.6 5021.0 5127.6 5188.2 5217.0 5224.9 4999.5 5025.4 5136.0 5180.1 5240.6 5063.7 5106.3 5123.5 5128.7 5150.6 5090.2 5102.1 5134.3 5147.8 5190.3 4854.4 5040.8 5067.3 5118.5 5129.4 5478.7 5623.4 5645.8 5658.7 5724.8 4543.3 6166.8 6184.5 6201.6 6225.4 6052.1 6103.7 6217.7 6261.0 6264.1 5665.3 5741.9 5767.0 5784.4 5804.6 6171.7 6188.8 6237.0 6243.7 6248.3 5469.7 5897.6 6079.1 6086.4 6097.5 5672.8 6151.5 6179.6 6190.8 6210.7 5423.2 5743.7 6127.2 6153.4 6157.2 4569.8 5933.3 5969.2 6082.2 6179.5 3804.9 4116.2 4887.2 4895.6 5137.1 3878.5 4386.3 4402.6 4410.6 4438.1 5571.4 5664.0 5677.7 5717.3 5729.6 6089.4 6089.5 6120.5 6165.4 6178.6 5648.1 5661.5 5709.9 5714.3 5722.1 4640.5 5245.5 5362.9 5370.5 5374.7 6121.3 6144.1 6167.5 6235.8 6238.8 6161.3 6167.1 6167.4 6171.4 6204.9 6084.5 6163.9 6236.8 6249.2 6252.5 6000.2 6014.3 6044.8 6112.0 6121.6 5137.0 6089.3 6136.0 6153.0 6161.9 5819.3 5856.2 6072.6 6080.9 6090.4 5931.7 6010.9 6046.1 6054.8 6092.6 5513.7 5699.5 5842.6 5902.4 5943.5 5838.3 6017.5 6055.4 6059.4 6084.8 5799.0 5866.3 5869.8 5948.5 6004.8 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:71795.31 Median:22686.23 stddev:157589.48 (694.6%) stddev-sans-first:157940.69 20:30:04 INFO - PROCESS | 1664 | Values: 520.3 529.6 535.1 537.9 571.3 30535.1 40875.8 41004.4 41024.6 41057.4 42204.8 42802.8 42864.6 42919.1 42965.0 9611.3 9819.6 9830.4 9834.3 9838.8 9642.2 9751.7 9754.0 9766.8 9770.7 9736.1 9785.0 9793.7 9799.5 9805.0 9724.8 9733.8 9769.6 9787.6 9795.0 9704.9 9761.9 9768.2 9782.5 9788.4 40010.0 40093.8 40267.0 40353.4 40420.8 3093.0 3500.0 3528.5 3616.0 4118.7 31704.8 32506.8 32597.2 32870.5 32985.7 2774.9 3215.9 3250.8 3271.3 3345.3 492266.0 495213.0 496006.0 497259.0 498454.5 61471.7 61563.7 61877.7 62079.0 62352.4 34927.0 56985.0 61168.1 65286.7 65544.3 15936.6 16623.0 16789.2 16796.6 16830.0 12414.0 12416.8 12475.8 12486.7 12499.4 18427.2 18759.7 19496.0 19855.1 19896.6 8179.2 8377.3 8383.7 8394.7 8521.8 733.9 792.8 904.3 929.8 949.3 30034.5 30424.7 30601.8 31368.4 31394.9 946.3 959.6 1046.1 1066.0 1216.7 13311.7 14135.9 16093.6 16136.1 16474.0 650390.0 694344.1 694781.0 695895.5 699505.0 59461.1 60048.0 60202.4 60233.1 60427.1 1240.8 1321.6 1342.0 1396.9 1405.5 29767.8 30399.5 30636.8 30687.2 30930.8 52683.7 52901.5 53162.5 53181.5 53201.5 450035.0 591909.0 593130.0 595706.0 598222.0 27210.0 27236.6 27565.4 27853.2 27960.4 48932.8 49590.0 49861.5 49957.8 50102.7 38299.6 40377.6 40834.0 41253.8 41836.8 40288.0 40412.8 40436.0 40616.8 41729.2 34154.1 38287.0 38360.6 39100.6 39172.8 35242.8 35598.1 36038.9 36079.8 36269.3 22506.7 24404.8 26236.6 26306.3 26331.5 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35292.59 Median:2011.40 stddev:103167.40 (5129.1%) stddev-sans-first:103423.41 20:30:04 INFO - PROCESS | 1664 | Values: 329.5 370.2 375.9 384.6 395.0 19881.9 20282.5 20709.0 20841.4 21147.5 20368.3 20511.9 20665.4 20835.3 21059.8 5040.3 5393.9 5671.2 6133.8 6212.3 3994.1 5917.1 6078.2 6217.0 6236.6 6060.2 6230.3 6236.9 6252.7 6253.7 6754.7 6866.4 6867.7 6881.4 6886.9 5089.2 5350.4 5442.2 6016.6 6050.8 13327.2 13351.3 13472.1 13558.6 13624.3 2088.6 2117.8 2133.4 2178.6 2269.7 10123.8 10575.5 10687.6 12325.6 15074.4 1880.8 1894.3 1900.7 1934.1 1951.6 106890.5 107695.0 118894.7 127716.0 129208.0 11422.5 11448.7 11538.5 11706.9 11903.0 14425.9 14432.6 14460.0 14463.3 14493.0 8045.0 8176.8 8319.5 8487.9 8644.2 7133.0 8402.9 8442.9 8457.9 8630.9 4509.1 4554.5 4571.2 4602.9 4671.1 1590.6 1927.9 3183.0 3652.6 3707.5 869.8 877.5 885.7 940.0 1008.5 19366.9 21119.0 21423.8 21959.7 22028.9 929.4 950.5 964.5 978.4 1047.8 8730.0 9459.2 11198.0 11375.0 11449.8 595914.0 599478.0 617884.0 628027.0 639671.0 80716.0 140874.0 150929.0 151857.7 155612.9 422.6 442.4 445.0 445.1 445.3 10491.9 10954.3 11668.7 11827.9 11832.6 32392.3 56951.7 58210.7 58265.0 58957.0 76086.9 78411.6 79558.8 80484.6 83956.2 5615.4 5964.5 7759.5 8081.5 8642.0 11474.5 12560.9 12813.3 13030.8 13288.6 10675.6 11406.2 11412.4 11456.3 11539.5 8918.8 9951.1 10022.3 10401.6 11425.9 9984.4 11125.6 11244.4 11648.6 11708.3 8053.4 8175.4 8287.6 8297.9 8422.9 8224.8 10921.5 11343.5 11417.1 11421.7 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5706.85 Median:4999.92 stddev:3221.58 (64.4%) stddev-sans-first:3214.72 20:30:04 INFO - PROCESS | 1664 | Values: 1448.1 1523.0 1690.9 1809.4 1825.7 7835.4 8471.4 8572.1 8975.3 9017.3 7684.6 8531.5 8593.8 8756.9 8760.6 2126.5 2290.7 2317.1 2347.0 2349.7 1989.5 2227.8 2329.7 2339.7 2344.1 2322.1 2325.8 2329.2 2337.2 2351.9 2298.7 2300.4 2318.9 2327.6 2329.9 2295.3 2298.6 2302.5 2307.7 2309.5 8818.0 8833.7 8857.8 8871.5 8878.0 5116.6 5330.4 5332.1 5347.5 5358.8 3322.2 3477.5 3511.4 3566.5 3626.1 1077.7 1083.5 1083.8 1087.5 1107.1 11763.4 11857.6 11952.9 11980.7 11990.0 4524.9 4678.1 4777.9 4779.9 4796.2 9863.9 9966.6 10000.5 10017.4 10046.5 5308.5 5316.5 5316.7 5336.9 5358.9 4316.8 4603.5 4820.2 4872.2 4875.0 3866.3 3891.4 3991.2 4016.8 4029.8 1254.9 1262.9 1268.9 1270.7 1274.2 793.0 813.5 844.9 905.1 942.0 5735.6 5773.0 5800.3 5977.2 6099.2 736.0 952.5 956.0 965.6 969.6 3312.6 3353.8 3911.7 4009.2 4072.4 9569.0 10412.0 10795.8 10798.5 10826.0 10757.6 10811.4 10829.2 10867.6 10885.7 7709.5 7944.7 8137.6 8137.9 8290.9 5916.1 5927.0 5955.6 6026.7 6039.5 9700.6 9880.4 9888.0 9937.3 9965.9 9782.0 10117.5 10237.0 10246.3 10276.4 6795.6 7389.3 7554.1 7566.6 7649.9 8380.9 8386.2 8416.9 8507.2 8563.8 7482.5 7657.6 7663.3 7721.8 7744.4 7381.0 7417.3 7449.5 7549.4 7585.0 6975.4 7059.0 7090.5 7106.8 7116.6 4634.5 4661.4 4884.9 5048.9 5050.7 4948.2 4951.0 5082.2 5113.8 5205.4 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4547.33 Median:4943.41 stddev:1419.15 (28.7%) stddev-sans-first:1386.80 20:30:04 INFO - PROCESS | 1664 | Values: 296.4 308.2 312.6 315.9 316.1 4267.3 4662.0 5394.3 5530.9 5560.3 5316.6 5474.4 5552.6 5556.2 5619.3 3508.8 3903.8 4240.6 4251.5 4256.9 3951.5 4176.1 4240.4 4256.7 4268.3 3376.5 4134.2 4144.2 4156.8 4158.3 3603.5 4152.1 4166.0 4172.2 4180.1 3313.2 3611.9 3618.6 3634.8 3637.0 4267.7 4751.5 5442.6 5452.5 5460.1 3581.9 3936.0 4232.3 4636.9 4769.3 4539.5 5076.9 5577.7 5839.1 5897.7 3366.8 3833.2 3934.5 3956.8 3987.7 6115.5 6138.5 6142.9 6152.3 6191.6 3548.5 4007.9 4011.9 4018.6 4029.3 3734.6 3931.4 4003.6 4056.5 4102.9 4701.3 4734.5 4735.9 4749.2 4765.3 5663.6 5879.5 5901.3 5906.8 5934.1 1154.5 1291.5 1294.7 1316.7 1354.9 904.9 907.7 923.9 935.4 937.1 4901.4 5379.7 5417.7 5428.7 5505.4 5556.0 5634.2 5951.8 6007.6 6051.7 4826.7 5138.4 5228.5 5251.2 5492.3 2157.6 2567.0 2658.5 2678.3 2681.0 4757.6 5107.3 5229.5 5265.8 5306.6 4426.5 4698.8 4763.7 5104.7 5197.6 4405.6 4561.6 5242.8 5271.4 5304.3 4329.8 4427.9 4532.8 4798.9 4927.7 4921.4 4980.7 5372.6 5999.9 6029.3 6313.3 6336.7 6364.7 6374.3 6406.4 4018.6 4037.0 4046.7 4047.4 4079.1 4959.2 5341.5 5417.3 5514.3 5591.6 4910.7 5254.2 5702.0 5856.5 5939.7 5254.0 5390.0 5649.1 5924.8 5931.0 5235.5 5364.0 5713.8 5844.8 5885.8 4679.4 5192.9 5287.5 5959.7 5966.2 5616.2 5787.9 5823.8 5849.9 5855.9 20:30:04 INFO - PROCESS | 1664 | 20:30:04 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:25303.86 Median:3750.42 stddev:40886.61 (1090.2%) stddev-sans-first:40959.58 20:30:04 INFO - PROCESS | 1664 | Values: 701.4 717.0 720.4 764.3 867.5 13995.9 15255.5 15289.9 15968.6 16134.1 13998.7 14553.3 14579.6 14646.9 14692.8 845.6 866.2 867.6 870.2 872.8 689.2 825.3 845.8 856.7 857.6 900.1 909.6 909.7 910.0 910.2 879.2 901.4 904.2 904.3 905.0 654.6 665.5 668.6 675.6 676.9 15147.4 15199.5 15205.6 15207.7 15232.8 14757.6 14798.9 14817.9 14878.3 15123.6 10292.3 10442.8 11008.7 11909.2 11935.3 3540.8 3793.7 3866.9 3917.4 4059.1 122971.0 125067.7 126659.0 128164.0 128265.4 11459.4 11568.1 11576.2 11633.2 11752.9 20045.0 20203.9 23871.0 23935.2 24001.3 7524.9 7635.2 7675.0 7756.1 7837.8 4605.3 4655.4 4665.8 4680.1 4792.0 3665.6 3743.1 3757.8 3793.2 3794.4 642.0 647.2 651.9 654.4 655.2 532.2 661.4 672.6 682.8 692.0 9279.6 9357.8 9412.3 9493.5 9793.2 644.5 657.7 658.7 669.6 682.4 4424.0 4485.6 4653.0 4673.9 4724.9 99154.5 99711.0 107078.4 165460.0 174433.0 134976.0 135328.0 136259.3 137333.0 137636.6 79070.2 79807.0 118907.0 121435.4 121752.0 8991.3 9017.1 9052.5 9063.5 9124.8 68048.0 69399.4 69747.7 69764.7 70024.6 104731.0 105738.5 108142.5 108650.5 109174.0 11816.4 12189.8 12214.9 12240.9 12420.9 13015.9 13133.2 13393.5 13446.7 13967.1 12517.6 12620.4 12673.9 12851.4 12854.2 12173.6 12404.7 12445.8 12776.1 12813.7 10652.0 12280.8 12509.9 12529.2 12556.3 10606.6 10653.6 10840.3 10871.5 11559.0 8465.8 8637.6 9450.6 10695.2 10754.5 20:30:04 INFO - PROCESS | 1664 | -------- Summary: end -------- 20:30:04 INFO - PROCESS | 1664 | 20:30:05 INFO - TEST-INFO | 1664: exit 0 20:30:05 INFO - TEST-OK | dromaeo_css | took 1113855ms 20:30:05 INFO - TEST-START | kraken 20:30:05 INFO - operating with platform_type : mac_ 20:30:05 INFO - Initialising browser for kraken test... 20:30:05 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpI3rzVH/profile http://localhost:49270/getInfo.html) 20:30:07 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 20:30:07 INFO - PROCESS | 1676 | colorDepth:24 20:30:07 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 20:30:07 INFO - PROCESS | 1676 | __metrics 20:30:08 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:30:08 INFO - TEST-INFO | 1676: exit 0 20:30:08 INFO - Browser initialized. 20:30:08 INFO - Running cycle 1/1 for kraken test... 20:30:08 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpI3rzVH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:20 INFO - PROCESS | 1678 | RSS: Main: 254824448 20:30:20 INFO - PROCESS | 1678 | 20:30:23 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 20:30:24 INFO - PROCESS | 1678 | RSS: Main: 267579392 20:30:24 INFO - PROCESS | 1678 | 20:30:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 20:30:28 INFO - PROCESS | 1678 | RSS: Main: 276230144 20:30:28 INFO - PROCESS | 1678 | 20:30:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 20:30:31 INFO - PROCESS | 1678 | RSS: Main: 279207936 20:30:31 INFO - PROCESS | 1678 | 20:30:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 20:30:34 INFO - PROCESS | 1678 | RSS: Main: 281595904 20:30:34 INFO - PROCESS | 1678 | 20:30:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:30:37 INFO - PROCESS | 1678 | RSS: Main: 281972736 20:30:37 INFO - PROCESS | 1678 | 20:30:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 20:30:41 INFO - PROCESS | 1678 | RSS: Main: 281964544 20:30:41 INFO - PROCESS | 1678 | 20:30:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 20:30:44 INFO - PROCESS | 1678 | RSS: Main: 282599424 20:30:44 INFO - PROCESS | 1678 | 20:30:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 20:30:48 INFO - PROCESS | 1678 | RSS: Main: 282738688 20:30:48 INFO - PROCESS | 1678 | 20:30:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:30:50 INFO - PROCESS | 1678 | RSS: Main: 282501120 20:30:50 INFO - PROCESS | 1678 | 20:30:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:30:53 INFO - PROCESS | 1678 | RSS: Main: 282640384 20:30:53 INFO - PROCESS | 1678 | 20:30:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:30:56 INFO - PROCESS | 1678 | RSS: Main: 282931200 20:30:56 INFO - PROCESS | 1678 | 20:30:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:30:59 INFO - PROCESS | 1678 | RSS: Main: 282996736 20:30:59 INFO - PROCESS | 1678 | 20:31:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:31:03 INFO - PROCESS | 1678 | RSS: Main: 283127808 20:31:03 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 20:31:05 INFO - PROCESS | 1678 | RSS: Main: 284172288 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | __start_tp_report 20:31:05 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 20:31:05 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 20:31:05 INFO - PROCESS | 1678 | |i|pagename|runs| 20:31:05 INFO - PROCESS | 1678 | |0;ai-astar;105;154;151;136;117;120;114;124;152;117 20:31:05 INFO - PROCESS | 1678 | |1;audio-beat-detection;148;111;131;161;108;132;151;138;156;123 20:31:05 INFO - PROCESS | 1678 | |2;audio-dft;203;211;229;199;199;200;196;199;200;193 20:31:05 INFO - PROCESS | 1678 | |3;audio-fft;72;82;77;141;60;61;60;65;136;63 20:31:05 INFO - PROCESS | 1678 | |4;audio-oscillator;71;70;121;72;74;78;114;70;72;115 20:31:05 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;109;131;86;133;134;85;112;112;137;131 20:31:05 INFO - PROCESS | 1678 | |6;imaging-darkroom;104;95;95;95;96;101;153;121;94;96 20:31:05 INFO - PROCESS | 1678 | |7;imaging-desaturate;91;96;124;84;139;140;120;90;82;136 20:31:05 INFO - PROCESS | 1678 | |8;json-parse-financial;56;56;55;56;56;56;57;56;58;58 20:31:05 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;58;69;91;116;117;79;73;75;86;75 20:31:05 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;88;84;78;99;97;85;86;87;90;89 20:31:05 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;145;143;154;140;130;147;158;167;170;183 20:31:05 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;184;183;207;260;185;184;185;183;184;181 20:31:05 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;71;71;71;71;70;69;69;74;70;72 20:31:05 INFO - PROCESS | 1678 | __end_tp_report 20:31:05 INFO - PROCESS | 1678 | __start_cc_report 20:31:05 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1079 20:31:05 INFO - PROCESS | 1678 | __end_cc_report 20:31:05 INFO - PROCESS | 1678 | __startTimestamp1470972665530__endTimestamp 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | ------- Summary: start ------- 20:31:05 INFO - PROCESS | 1678 | Number of tests: 14 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:129.00 Median:130.00 stddev:17.89 (13.8%) stddev-sans-first:16.74 20:31:05 INFO - PROCESS | 1678 | Values: 105.0 154.0 151.0 136.0 117.0 120.0 114.0 124.0 152.0 117.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:143.00 stddev:18.31 (12.8%) stddev-sans-first:18.89 20:31:05 INFO - PROCESS | 1678 | Values: 148.0 111.0 131.0 161.0 108.0 132.0 151.0 138.0 156.0 123.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:202.90 Median:200.00 stddev:10.30 (5.2%) stddev-sans-first:10.93 20:31:05 INFO - PROCESS | 1678 | Values: 203.0 211.0 229.0 199.0 199.0 200.0 196.0 199.0 200.0 193.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:81.70 Median:64.00 stddev:30.88 (48.2%) stddev-sans-first:32.55 20:31:05 INFO - PROCESS | 1678 | Values: 72.0 82.0 77.0 141.0 60.0 61.0 60.0 65.0 136.0 63.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:71.50 stddev:21.57 (30.2%) stddev-sans-first:22.21 20:31:05 INFO - PROCESS | 1678 | Values: 71.0 70.0 121.0 72.0 74.0 78.0 114.0 70.0 72.0 115.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:133.50 stddev:19.54 (14.6%) stddev-sans-first:20.51 20:31:05 INFO - PROCESS | 1678 | Values: 109.0 131.0 86.0 133.0 134.0 85.0 112.0 112.0 137.0 131.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:95.00 stddev:18.74 (19.7%) stddev-sans-first:19.87 20:31:05 INFO - PROCESS | 1678 | Values: 104.0 95.0 95.0 95.0 96.0 101.0 153.0 121.0 94.0 96.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:110.20 Median:83.00 stddev:23.87 (28.8%) stddev-sans-first:24.29 20:31:05 INFO - PROCESS | 1678 | Values: 91.0 96.0 124.0 84.0 139.0 140.0 120.0 90.0 82.0 136.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 20:31:05 INFO - PROCESS | 1678 | Values: 56.0 56.0 55.0 56.0 56.0 56.0 57.0 56.0 58.0 58.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:83.90 Median:75.00 stddev:19.36 (25.8%) stddev-sans-first:18.13 20:31:05 INFO - PROCESS | 1678 | Values: 58.0 69.0 91.0 116.0 117.0 79.0 73.0 75.0 86.0 75.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.50 stddev:6.11 (6.9%) stddev-sans-first:6.48 20:31:05 INFO - PROCESS | 1678 | Values: 88.0 84.0 78.0 99.0 97.0 85.0 86.0 87.0 90.0 89.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:156.00 stddev:16.00 (10.3%) stddev-sans-first:16.66 20:31:05 INFO - PROCESS | 1678 | Values: 145.0 143.0 154.0 140.0 130.0 147.0 158.0 167.0 170.0 183.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:184.50 stddev:24.49 (13.3%) stddev-sans-first:25.72 20:31:05 INFO - PROCESS | 1678 | Values: 184.0 183.0 207.0 260.0 185.0 184.0 185.0 183.0 184.0 181.0 20:31:05 INFO - PROCESS | 1678 | 20:31:05 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 20:31:05 INFO - PROCESS | 1678 | Values: 71.0 71.0 71.0 71.0 70.0 69.0 69.0 74.0 70.0 72.0 20:31:05 INFO - PROCESS | 1678 | -------- Summary: end -------- 20:31:05 INFO - PROCESS | 1678 | 20:31:06 INFO - TEST-INFO | 1678: exit 0 20:31:06 INFO - TEST-OK | kraken | took 61282ms 20:31:06 INFO - SUITE-END | took 1175s 20:31:06 INFO - Completed test suite (00:19:35) 20:31:06 INFO - javascript benchmark 20:31:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7306.01989692594, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.310671652236, 3373.1398493384168, 3400.200952776097, 3411.3006833599115, 3423.1955490459745, 5515.917261241075, 5591.273134492515, 5618.2415373924505, 5650.293713285834, 5708.372079071299, 5503.862403439906, 5554.583406244537, 5570.470805273502, 5597.356304025038, 5715.571332150084, 5020.97489512552, 5127.615428842833, 5188.221766734982, 5216.973915130419, 5224.8693782655355, 4999.500049995007, 5025.3718285214345, 5136.049830781299, 5180.067587834188, 5240.60695447841, 5063.74681265937, 5106.285120083191, 5123.487651234866, 5128.71792051437, 5150.613703972217, 5090.160123579605, 5102.132637451605, 5134.332536770234, 5147.794088236466, 5190.325257716473, 4854.417469903634, 5040.823571175028, 5067.265246539231, 5118.488151184889, 5129.410117836459, 5478.671279723189, 5623.409541998072, 5645.830625081254, 5658.7170641467765, 5724.79963201286, 4543.34121552373, 6166.814995550096, 6184.474319682832, 6201.596896201732, 6225.408586184305, 6052.061930400795, 6103.664298463583, 6217.658028808413, 6260.968695156541, 6264.060390941349, 5665.320161580596, 5741.88516229673, 5767.0, 5784.421557844182, 5804.564657650609, 6171.660558669317, 6188.845278867974, 6237.033259844731, 6243.687815609202, 6248.31268560458, 5469.659933316363, 5897.557683173779, 6079.088136779518, 6086.360932102154, 6097.512199024068, 5672.773089076473, 6151.507879369639, 6179.567430279837, 6190.845228869314, 6210.658413787285, 5423.240746295522, 5743.712814359265, 6127.234095738033, 6153.446189842935, 6157.230346206724, 4569.817207311737, 5933.258342707161, 5969.194158788595, 6082.2093127893095, 6179.5056395488255, 3804.904877378088, 4116.217918595457, 4887.193613053877, 4895.559399654048, 5137.075326441276, 3878.4957955466175, 4386.2762644163995, 4402.625776808943, 4410.6030457259, 4438.090191510732, 5571.387147413781, 5664.0, 5677.744501497443, 5717.256756621613, 5729.627574207663, 6089.360617135226, 6089.48239399656, 6120.510359171256, 6165.414285642857, 6178.62928224299, 5648.124540696199, 5661.46216109469, 5709.915116127922, 5714.257146570919, 5722.11307247369, 4640.466346370143, 5245.475452454801, 5362.91955620666, 5370.516653501204, 5374.731263436813, 6121.300552271563, 6144.126041557368, 6167.475764560063, 6235.75056997715, 6238.75044998195, 6161.291451483136, 6167.1366008759705, 6167.444929956326, 6171.413715697002, 6204.937950620436, 6084.452399284086, 6163.907541386972, 6236.781712640036, 6249.218847644044, 6252.468540174136, 6000.249968753906, 6014.278286605635, 6044.788432404845, 6111.98679349419, 6121.632702037892, 5136.998285334324, 6089.299730530868, 6135.98756205239, 6153.0, 6161.938380616137, 5819.330776960704, 5856.180134781219, 6072.574919755752, 6080.90878636812, 6090.3605121461605, 5931.673757943355, 6010.939890601038, 6046.09308603713, 6054.848628784315, 6092.634441933498, 5513.724313784375, 5699.458551437607, 5842.591018628656, 5902.38025007368, 5943.465088142088, 5838.2702162229725, 6017.458428741259, 6055.424734650202, 6059.424354686298, 6084.756609735561, 5799.043157878903, 5866.2960444746905, 5869.794557190648, 5948.464638182411, 6004.789832355847], "value": 5572.745235888086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.2690220240562, 529.6133822309713, 535.085004642062, 537.9300690910181, 571.3372487914015, 30535.083947481555, 40875.79562102189, 41004.38493422601, 41024.58975410249, 41057.38413923793, 42204.788976055155, 42802.78598607011, 42864.57135428645, 42919.14161716764, 42965.0, 9611.279154063439, 9819.558119884623, 9830.410175389463, 9834.26243031772, 9838.754031149207, 9642.180414664763, 9751.707448776548, 9754.0, 9766.804663906718, 9770.658026969057, 9736.123748862601, 9785.021497850194, 9793.706188814347, 9799.510024498783, 9804.950975245149, 9724.756881077994, 9733.805323893517, 9769.609215631366, 9787.608495660237, 9795.02049795022, 9704.854427183598, 9761.853572196424, 9768.21854251658, 9782.51087445625, 9788.412695238309, 40010.0, 40093.79953100216, 40267.0, 40353.39469907954, 40420.79789601063, 3092.969070309313, 3499.9650003500146, 3528.541289632357, 3616.0055984604446, 4118.670506359514, 31704.841475792706, 32506.837465812758, 32597.185070373194, 32870.506942395885, 32985.67014329874, 2774.902878399246, 3215.8713651453913, 3250.7724459287624, 3271.313024264907, 3345.280764635591, 492266.0, 495213.0, 496006.0, 497259.0, 498454.5077274627, 61471.69264153651, 61563.6921815397, 61877.69061154756, 62079.0, 62352.376476235564, 34927.0, 56985.0, 61168.08247876285, 65286.673566631864, 65544.34455655477, 15936.601584960468, 16623.0, 16789.16054197285, 16796.58008549796, 16830.0, 12414.0, 12416.75166496665, 12475.750484990249, 12486.687832804253, 12499.3750312484, 18427.170777315052, 18759.718604220947, 19496.009953878263, 19855.106520206624, 19896.60206795856, 8179.222973817477, 8377.287930525974, 8383.664653413794, 8394.664213431395, 8521.786955326043, 733.9266073392724, 792.8464084756665, 904.3127223310331, 929.8419268724333, 949.3402085550614, 30034.549481757793, 30424.69575304263, 30601.846990764905, 31368.37263254768, 31394.901178458644, 946.2997381937455, 959.6497278493439, 1046.0689985912543, 1066.0405634928627, 1216.7262365967763, 13311.73376532464, 14135.869130469539, 16093.597660058358, 16136.112513811853, 16474.0, 650390.0, 694344.056559438, 694781.0, 695895.5205223941, 699505.0, 59461.10808337792, 60048.0, 60202.39797601968, 60233.09650355248, 60427.09359359613, 1240.8324876141785, 1321.6365499487526, 1342.033735710287, 1396.8533304003136, 1405.5361730628663, 29767.80928762912, 30399.54400683947, 30636.84681576667, 30687.2328191797, 30930.76276948987, 52683.73658131685, 52901.470985289656, 53162.46837531575, 53181.46818531765, 53201.4679853212, 450035.0, 591909.0404548122, 593130.0, 595706.0, 598222.0, 27210.0, 27236.591451127853, 27565.448691025667, 27853.16440506788, 27960.44079118447, 48932.755336224516, 49590.0, 49861.501384985684, 49957.75021124871, 50102.74948625379, 38299.61700383072, 40377.596224037385, 40834.0, 41253.793731032354, 41836.79081604572, 40288.0, 40412.79793601013, 40436.0, 40616.79691601523, 41729.1654166921, 34154.14614634654, 38287.04282392962, 38360.616393835706, 39100.63147789814, 39172.80413597914, 35242.82378588091, 35598.11004724903, 36038.91883243507, 36079.81960090183, 36269.27461450809, 22506.66240006434, 24404.75595244025, 26236.606450903633, 26306.34234144085, 26331.473370532865], "value": 20281.823210276798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.53535514923954, 370.17451084082495, 375.8552957111512, 384.5942530630184, 395.0223197585975, 19881.900590497044, 20282.492937676547, 20709.0, 20841.374758757225, 21147.47131321718, 20368.287109951154, 20511.897440512777, 20665.380038598865, 20835.27076552317, 21059.789402105973, 5040.319556859814, 5393.892122157555, 5671.177679236508, 6133.785317513888, 6212.347703491136, 3994.0613955720382, 5917.112433135021, 6078.240219972504, 6217.0, 6236.6258024518675, 6060.181875446824, 6230.25236971564, 6236.875262494747, 6252.687365631723, 6253.6873156342, 6754.66226688666, 6866.416354609839, 6867.656617169122, 6881.380675739158, 6886.931130688704, 5089.236614507853, 5350.384705758848, 5442.210879422461, 6016.578839481238, 6050.788222412239, 13327.200367977952, 13351.265680387574, 13472.056956013083, 13558.593242202749, 13624.318784060757, 2088.631946075323, 2117.8093971542635, 2133.4453042208984, 2178.6405243134864, 2269.6595510673365, 10123.797524049478, 10575.471226438647, 10687.572497100107, 12325.568605098868, 15074.397024119022, 1880.8401285890716, 1894.3180455036177, 1900.6673832079468, 1934.1103092577432, 1951.590166065128, 106890.46554767255, 107695.0, 118894.68633801186, 127716.0, 129208.0, 11422.543098275975, 11448.713782155346, 11538.480768365444, 11706.941465292619, 11902.988245999188, 14425.92787036079, 14432.639184020483, 14460.0, 14463.349149288308, 14492.98549101574, 8044.959775201087, 8176.836463270702, 8319.542425166674, 8487.872681909776, 8644.178803013703, 7132.964335178394, 8402.873956890651, 8442.929046923196, 8457.873131903027, 8630.870536941951, 4509.120721459284, 4554.4990051094355, 4571.2000399929875, 4602.88492787683, 4671.11248862715, 1590.6023494126468, 1927.9492676491345, 3182.98408507956, 3652.6164752700583, 3707.480952666629, 869.826034793044, 877.4866702978701, 885.6900084970338, 939.9530023498797, 1008.5209525475487, 19366.903165484084, 21119.0, 21423.785762142492, 21959.67060494094, 22028.89855507218, 929.3504030346055, 950.5199874063553, 964.508100868548, 978.3933960944261, 1047.7537778622018, 8729.956350218208, 9459.24326053914, 11198.0, 11374.976252137347, 11449.828252576219, 595914.0, 599478.0, 617884.0, 628027.0, 639671.0, 80716.0, 140874.0, 150929.0, 151857.72213416809, 155612.88774224452, 422.56053704147956, 442.4027562790272, 444.9911001779946, 445.125328729049, 445.3364486914539, 10491.895081049091, 10954.287971281841, 11668.70828229301, 11827.881721182677, 11832.645020649394, 32392.310537523033, 56951.715241423524, 58210.70894645499, 58265.0, 58957.0, 76086.8586971207, 78411.60794195993, 79558.80661790194, 80484.59757701174, 83956.16043839483, 5615.438456154516, 5964.493018093337, 7759.486900054435, 8081.515109093473, 8642.0, 11474.541018359507, 12560.937195313965, 12813.295268760308, 13030.804537932128, 13288.601341959757, 10675.583813179708, 11406.201565890307, 11412.429378530875, 11456.255343402652, 11539.480723367637, 8918.777030574287, 9951.104400603981, 10022.298439109192, 10401.635942741968, 11425.942870285595, 9984.35101718386, 11125.610603628835, 11244.381559014333, 11648.592299269485, 11708.297502149899, 8053.355731541345, 8175.427720059776, 8287.58562071906, 8297.917020829715, 8422.91577084246, 8224.794380140544, 10921.508532116233, 11343.546258149581, 11417.0866330695, 11421.714457138638], "value": 9200.948393896777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.1094127111826, 1522.9643842187309, 1690.8900921440106, 1809.3938530592243, 1825.71701386285, 7835.412344074203, 8471.407001509897, 8572.142785721424, 8975.326850486215, 9017.323700722447, 7684.615769211545, 8531.530765807893, 8593.828123437528, 8756.91243087569, 8760.649574017032, 2126.5002724359765, 2290.7365652949957, 2317.1079134533156, 2346.9765302347014, 2349.659299401586, 1989.4827344890289, 2227.7969896256004, 2329.650552417134, 2339.7426283108844, 2344.097522453859, 2322.071171531384, 2325.802306803924, 2329.1731435340466, 2337.2287145242112, 2351.9176828810996, 2298.747137814839, 2300.3903965449167, 2318.93043208704, 2327.6159433693506, 2329.871857047862, 2295.2655150351893, 2298.609236429811, 2302.4589221533092, 2307.6653885186556, 2309.549637820626, 8818.0, 8833.734987950373, 8857.822843543157, 8871.512066836322, 8878.0, 5116.565091967187, 5330.360356757175, 5332.066888294533, 5347.491988261109, 5358.758855851496, 3322.2026713588807, 3477.4609935460044, 3511.438169892805, 3566.465030245458, 3626.057225121461, 1077.7036315013356, 1083.496174278964, 1083.7615724540667, 1087.4508373271526, 1107.1143085531623, 11763.411829408495, 11857.5849845255, 11952.940235298855, 11980.700482488008, 11990.040796736328, 4524.886877828015, 4678.064387122521, 4777.904441911142, 4779.856604301876, 4796.208625576741, 9863.852042219372, 9966.551505182284, 10000.549975250986, 10017.398956062514, 10046.547905344278, 5308.46915308466, 5316.548093412026, 5316.6544174628525, 5336.866578335573, 5358.866028349323, 4316.762578058237, 4603.5396460353695, 4820.180569303227, 4872.1717308057005, 4875.0, 3866.284737323604, 3891.3968334908136, 3991.16185601027, 4016.819243134066, 4029.838806447768, 1254.861965183829, 1262.8800263974908, 1268.9428975696117, 1270.7140893299118, 1274.241826113461, 792.984140317202, 813.5281536708695, 844.923956843887, 905.1401168889581, 941.9811603767886, 5735.627184233012, 5773.0, 5800.332961709458, 5977.193078934375, 6099.176611157525, 735.9926400735924, 952.5094576293214, 955.9675550405545, 965.560669895196, 969.6266937229218, 3312.602487701443, 3353.7652364334263, 3911.706622003361, 4009.2182024505523, 4072.3891416287793, 9568.952155239318, 10412.0, 10795.78408431827, 10798.460076996118, 10826.0, 10757.569697212024, 10811.351318920733, 10829.24195306321, 10867.619633312795, 10885.727856803485, 7709.4603377763015, 7944.682212711542, 8137.552434616153, 8137.901383313177, 8290.917090829134, 5916.053431450947, 5927.0, 5955.583109182316, 6026.698665066817, 6039.456448919618, 9700.6119755209, 9880.35777674449, 9888.011198880055, 9937.304388692723, 9965.900340996497, 9781.951090244504, 10117.494125293559, 10236.976302369703, 10246.333988291035, 10276.383416995004, 6795.626240556817, 7389.334959853639, 7554.093508778982, 7566.583837888748, 7649.923500764921, 8380.874286885579, 8386.245237928615, 8416.873746893923, 8507.234348908629, 8563.785905352415, 7482.476226664081, 7657.61747593991, 7663.348615367756, 7721.7683469496005, 7744.380449563909, 7381.0, 7417.332440080419, 7449.515781474187, 7549.433792465697, 7585.0, 6975.407090397373, 7059.0, 7090.468214883801, 7106.786796396116, 7116.573005619679, 4634.536546345474, 4661.3707149534375, 4884.853454396374, 5048.864005598858, 5050.74746262678, 4948.233023881304, 4950.975245123751, 5082.161443361804, 5113.795448182031, 5205.375354957429], "value": 4568.860439296894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.3716920129326, 308.22635185683936, 312.58738465225906, 315.94474455319227, 316.09754151896334, 4267.335739061768, 4662.020975595129, 5394.298741163648, 5530.866172434651, 5560.304961879765, 5316.574674026078, 5474.39781624021, 5552.583556233279, 5556.194351818984, 5619.297587801525, 3508.7894726316504, 3903.8438462461468, 4240.575942405758, 4251.489821221442, 4256.936145957813, 3951.5258169019758, 4176.076746277603, 4240.363945408198, 4256.701705979691, 4268.338407546819, 3376.51040599113, 4134.235166494208, 4144.155850646448, 4156.750594964296, 4158.272302347093, 3603.5495563054487, 4152.110789590729, 4165.97917010413, 4172.207280616703, 4180.143070670505, 3313.2213929726495, 3611.8735844245325, 3618.6019537850816, 3634.800085995269, 3636.981815090934, 4267.658587313008, 4751.524847515256, 5442.564594832404, 5452.536534394581, 5460.126379779256, 3581.910452238689, 3935.9569714025806, 4232.343986682069, 4636.884077898079, 4769.284607308897, 4539.4779600346055, 5076.898462030776, 5577.745007373349, 5839.124131380327, 5897.705114744245, 3366.797992120456, 3833.195029043904, 3934.4688467056867, 3956.8021598920227, 3987.7300613496946, 6115.523213098702, 6138.47822935051, 6142.907856382158, 6152.261728592597, 6191.597546159485, 3548.509625957104, 4007.939880901789, 4011.91976160481, 4018.6383225509844, 4029.315016447211, 3734.6078661740125, 3931.4495970564144, 4003.619656132663, 4056.472658554369, 4102.91794164121, 4701.294805779092, 4734.526547345238, 4735.934414756721, 4749.1926372516755, 4765.332853400527, 5663.575231857627, 5879.470847623649, 5901.29184497863, 5906.763729450774, 5934.139549765347, 1154.549725607014, 1291.509226493945, 1294.7475242327844, 1316.7037416581193, 1354.94991381678, 904.9321800275607, 907.677774390082, 923.9307051970994, 935.354605322339, 937.1097457415483, 4901.43633482147, 5379.704116273564, 5417.724555686542, 5428.67427954324, 5505.366882808448, 5555.999920014356, 5634.1830434586755, 5951.761929522857, 6007.579469437185, 6051.667158306335, 4826.696791866177, 5138.409082955508, 5228.503292187236, 5251.238570407269, 5492.286002819608, 2157.64398874184, 2567.0245306783304, 2658.5469338857724, 2678.3304173956512, 2681.016048124374, 4757.643176761757, 5107.31458618655, 5229.450907654642, 5265.8146869048915, 5306.62853600252, 4426.513083560806, 4698.8120475181295, 4763.69036012658, 5104.719240441737, 5197.58419326453, 4405.625521830681, 4561.635069194523, 5242.842714718565, 5271.393789714155, 5304.310439642899, 4329.8051587678, 4427.867163985085, 4532.818687252473, 4798.904021919472, 4927.655064145475, 4921.4497433309825, 4980.729913871939, 5372.5701943843615, 5999.880002400015, 6029.306629737636, 6313.337099604659, 6336.683165841598, 6364.681765911779, 6374.298827129105, 6406.391392817675, 4018.618231268025, 4037.031112532912, 4046.676265898662, 4047.3928910662457, 4079.103217004107, 4959.156943319716, 5341.465853414627, 5417.268668729671, 5514.28314319152, 5591.552675785846, 4910.656254062182, 5254.238135470259, 5701.971490142523, 5856.502197313276, 5939.703014849154, 5253.973730131325, 5390.0, 5649.096144616841, 5924.7926322578505, 5930.991731405585, 5235.528802407802, 5363.973180134074, 5713.8285851424525, 5844.8310337933435, 5885.823425297248, 4679.368285281444, 5192.922106168486, 5287.471252874681, 5959.67221802805, 5966.164736936919, 5616.170612830729, 5787.913181302368, 5823.806119745357, 5849.912251316148, 5855.94144058554], "value": 4097.781129531675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.424831638057, 716.9820754481141, 720.4128635162342, 764.3273918951322, 867.4535042922957, 13995.860041399583, 15255.47445255474, 15289.923550382246, 15968.600784980366, 16134.112623805686, 13998.720025599507, 14553.345099470524, 14579.562613121623, 14646.853531464709, 14692.779608305884, 845.5941148248844, 866.2117473099481, 867.5835598912525, 870.2037635563452, 872.7774417523523, 689.2108535726616, 825.2861274997144, 845.7589586967715, 856.6958729650978, 857.5540718826238, 900.1403659505189, 909.5679552212712, 909.6997990663066, 910.0308171797049, 910.2263076385086, 879.160401816264, 901.3555307954779, 904.1726819959729, 904.3443503460005, 904.9999750275949, 654.6039646014141, 665.5174998126369, 668.6021817018866, 675.5912672832915, 676.8510927595921, 15147.394104235816, 15199.544013679608, 15205.619859503491, 15207.695846083016, 15232.771508427382, 14757.557273281818, 14798.852011479963, 14817.851821481754, 14878.330475128645, 15123.621909452242, 10292.330998485075, 10442.843357349646, 11008.669739907735, 11909.166358354918, 11935.343556104412, 3540.7521473496868, 3793.715471339661, 3866.9226615467815, 3917.3536366499493, 4059.0867054912705, 122971.0, 125067.74932250743, 126659.0, 128164.0, 128265.35867320604, 11459.369734664508, 11568.074554035657, 11576.189666723249, 11633.243839150427, 11752.88247117535, 20045.0, 20203.898980505004, 23871.0, 23935.16226932049, 24001.27996160118, 7524.946507488956, 7635.198304177981, 7674.96162519195, 7756.146823849372, 7837.804054898673, 4605.309203619417, 4655.4180727409075, 4665.790039448233, 4680.134175177603, 4792.017636384533, 3665.633436656313, 3743.082944678571, 3757.755745876509, 3793.2223894101644, 3794.4118661607495, 642.0113025940093, 647.1716203259834, 651.8533330000712, 654.3979538824293, 655.226832337846, 532.1645017322843, 661.4057843302269, 672.6244829324044, 682.8190529509684, 691.95860230354, 9279.582418791035, 9357.812843743088, 9412.341136120405, 9493.477858717837, 9793.216542676711, 644.5198327246231, 657.710607332772, 658.6607896933083, 669.5848573884223, 682.3585829320423, 4424.00721392165, 4485.618722408566, 4653.022865198346, 4673.929891051637, 4724.858254252378, 99154.50422747985, 99711.00288997017, 107078.3938240927, 165460.0, 174433.0, 134976.0, 135328.0, 136259.31870340585, 137333.0, 137636.5748936575, 79070.20929790744, 79806.99999999884, 118907.0, 121435.39282303886, 121752.0, 8991.325650576102, 9017.128062138912, 9052.456852588866, 9063.546822658709, 9124.817503650023, 68048.0, 69399.44804415533, 69747.65126174336, 69764.65117674379, 70024.64987675233, 104731.0, 105738.47130764298, 108142.45928770621, 108650.45674771891, 109174.0, 11816.350100744541, 12189.75620487603, 12214.938925305316, 12240.938795305967, 12420.937895310826, 13015.869841301466, 13133.212007279593, 13393.464261429433, 13446.731065378443, 13967.056106169171, 12517.56188533397, 12620.432080556213, 12673.873261267638, 12851.357432128543, 12854.228746275254, 12173.57392491294, 12404.689882753004, 12445.75108497843, 12776.10567260283, 12813.679658008625, 10652.0, 12280.754384912074, 12509.874901251234, 12529.248245105322, 12556.309402982924, 10606.628767993083, 10653.573857045942, 10840.267547875703, 10871.456427178768, 11559.017483513659, 8465.788355291166, 8637.56812159402, 9450.574724137292, 10695.197860160364, 10754.462276885968], "value": 7810.397916288211, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 154.0, 151.0, 136.0, 117.0, 120.0, 114.0, 124.0, 152.0, 117.0], "value": 129.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 131.0, 161.0, 108.0, 132.0, 151.0, 138.0, 156.0, 123.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 211.0, 229.0, 199.0, 199.0, 200.0, 196.0, 199.0, 200.0, 193.0], "value": 202.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 77.0, 141.0, 60.0, 61.0, 60.0, 65.0, 136.0, 63.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 121.0, 72.0, 74.0, 78.0, 114.0, 70.0, 72.0, 115.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 131.0, 86.0, 133.0, 134.0, 85.0, 112.0, 112.0, 137.0, 131.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 95.0, 95.0, 95.0, 96.0, 101.0, 153.0, 121.0, 94.0, 96.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 124.0, 84.0, 139.0, 140.0, 120.0, 90.0, 82.0, 136.0], "value": 110.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 69.0, 91.0, 116.0, 117.0, 79.0, 73.0, 75.0, 86.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 78.0, 99.0, 97.0, 85.0, 86.0, 87.0, 90.0, 89.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 154.0, 140.0, 130.0, 147.0, 158.0, 167.0, 170.0, 183.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 207.0, 260.0, 185.0, 184.0, 185.0, 183.0, 184.0, 181.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 71.0, 70.0, 69.0, 69.0, 74.0, 70.0, 72.0], "value": 70.8, "unit": "score"}]}]} 20:31:06 INFO - Return code: 0 20:31:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:31:06 ERROR - # TBPL SUCCESS # 20:31:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:31:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:31:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:31:06 INFO - 2016-08-11 20:31:06.849 screenresolution[1683:10675] starting screenresolution argv=screenresolution get 20:31:06 INFO - 2016-08-11 20:31:06.853 screenresolution[1683:10675] Display 0: 1600x1200x32@60 20:31:06 INFO - 2016-08-11 20:31:06.859 screenresolution[1684:10678] starting screenresolution argv=screenresolution list 20:31:06 INFO - Available Modes on Display 0 20:31:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:31:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:31:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:31:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:31:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:31:07 INFO - Intel Iris: 20:31:07 INFO - Chipset Model: Intel Iris 20:31:07 INFO - Type: GPU 20:31:07 INFO - Bus: Built-In 20:31:07 INFO - VRAM (Dynamic, Max): 1536 MB 20:31:07 INFO - Vendor: Intel (0x8086) 20:31:07 INFO - Device ID: 0x0a2e 20:31:07 INFO - Revision ID: 0x0009 20:31:07 INFO - Displays: 20:31:07 INFO - Display: 20:31:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:31:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:31:07 INFO - Display Serial Number: 1600x1200 60 20:31:07 INFO - Main Display: Yes 20:31:07 INFO - Mirror: Off 20:31:07 INFO - Online: Yes 20:31:07 INFO - Rotation: Supported 20:31:07 INFO - Return code: 0 20:31:07 INFO - Running post-action listener: _resource_record_post_action 20:31:07 INFO - [mozharness: 2016-08-12 03:31:07.099039Z] Finished run-tests step (success) 20:31:07 INFO - Running post-run listener: _resource_record_post_run 20:31:07 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37999616; Write bytes: 705055232; Read time: 385; Write time: 2114 20:31:07 INFO - TinderboxPrint: CPU usage
54.3% 20:31:07 INFO - TinderboxPrint: I/O read bytes / time
37,999,616 / 385 20:31:07 INFO - TinderboxPrint: I/O write bytes / time
705,055,232 / 2,114 20:31:07 INFO - TinderboxPrint: CPU idle
2,211.6 (45.7%) 20:31:07 INFO - TinderboxPrint: CPU system
977.9 (20.2%) 20:31:07 INFO - TinderboxPrint: CPU user
1,652.3 (34.1%) 20:31:07 INFO - TinderboxPrint: Swap in / out
441,438,208 / 0 20:31:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399690240; Write bytes: 394295296; Read time: 29892; Write time: 716 20:31:07 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35898368; Write bytes: 296788480; Read time: 355; Write time: 1354 20:31:07 INFO - Running post-run listener: _upload_blobber_files 20:31:07 INFO - Blob upload gear active. 20:31:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:31:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:31:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:08 INFO - (blobuploader) - INFO - Done attempting. 20:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:31:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:09 INFO - (blobuploader) - INFO - Done attempting. 20:31:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:31:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:31:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:31:12 INFO - (blobuploader) - INFO - Done attempting. 20:31:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:31:12 INFO - Return code: 0 20:31:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:31:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:31:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a130ddaee2748b129f78419eb771fc98c4fd3e398a358b1e66311562a2a8925efd5037258b7c675b78fb49b8876b409b5e6df758e567a53c18fb59070e83232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6852055ffbd25117bacbe2655b25afa82e85c8550cd27824e17a92e5dcd1d2203fe2a6bc43ecf145ceed94d165bb018ca46e5efed65b6ba2d7a1c7a2659f5a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddd8ab1d13d25303752699309a52c54adbd72792a449b0f9a9698537fcc7f8a243b87d7c13d31c9b1bc31aa52e79585816b1116b2cdc6724df21ded93801021f"} 20:31:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:31:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:31:12 INFO - Contents: 20:31:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a130ddaee2748b129f78419eb771fc98c4fd3e398a358b1e66311562a2a8925efd5037258b7c675b78fb49b8876b409b5e6df758e567a53c18fb59070e83232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6852055ffbd25117bacbe2655b25afa82e85c8550cd27824e17a92e5dcd1d2203fe2a6bc43ecf145ceed94d165bb018ca46e5efed65b6ba2d7a1c7a2659f5a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddd8ab1d13d25303752699309a52c54adbd72792a449b0f9a9698537fcc7f8a243b87d7c13d31c9b1bc31aa52e79585816b1116b2cdc6724df21ded93801021f"} 20:31:12 INFO - Running post-run listener: copy_logs_to_upload_dir 20:31:12 INFO - Copying logs to upload dir... 20:31:12 INFO - mkdir: /builds/slave/test/build/upload/logs 20:31:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.840343 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-11 20:31:12.840522) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 20:31:12.846539) ========= 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.fwEmdslo7s/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.c5i4fMZorw/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a130ddaee2748b129f78419eb771fc98c4fd3e398a358b1e66311562a2a8925efd5037258b7c675b78fb49b8876b409b5e6df758e567a53c18fb59070e83232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6852055ffbd25117bacbe2655b25afa82e85c8550cd27824e17a92e5dcd1d2203fe2a6bc43ecf145ceed94d165bb018ca46e5efed65b6ba2d7a1c7a2659f5a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddd8ab1d13d25303752699309a52c54adbd72792a449b0f9a9698537fcc7f8a243b87d7c13d31c9b1bc31aa52e79585816b1116b2cdc6724df21ded93801021f"} build_url:https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/X41KY8dhQNCx4d7_-lSZBg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0a130ddaee2748b129f78419eb771fc98c4fd3e398a358b1e66311562a2a8925efd5037258b7c675b78fb49b8876b409b5e6df758e567a53c18fb59070e83232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6852055ffbd25117bacbe2655b25afa82e85c8550cd27824e17a92e5dcd1d2203fe2a6bc43ecf145ceed94d165bb018ca46e5efed65b6ba2d7a1c7a2659f5a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ddd8ab1d13d25303752699309a52c54adbd72792a449b0f9a9698537fcc7f8a243b87d7c13d31c9b1bc31aa52e79585816b1116b2cdc6724df21ded93801021f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 20:31:12.881356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:31:12.881696) ========= 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.fwEmdslo7s/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.c5i4fMZorw/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005167 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 20:31:12.930980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 20:31:12.931308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 20:31:12.931649) ========= ========= Total master_lag: 0.75 =========