builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1479486363.93 results: success (0) buildid: 20161118060928 builduid: 6c0ad3f43e204c4f8622f086657268d7 revision: 48f5a1870ec3974ddf717576e6e54d345e476677 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:03.932341) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:03.932815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:03.933098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:03.959691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:03.960342) ========= 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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 08:26:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-11-18 08:26:04 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:04.131966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:04.132286) ========= 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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.027367 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:04.180815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:04.181176) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48f5a1870ec3974ddf717576e6e54d345e476677 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 48f5a1870ec3974ddf717576e6e54d345e476677 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 08:26:04,280 truncating revision to first 12 chars 2016-11-18 08:26:04,280 Setting DEBUG logging. 2016-11-18 08:26:04,280 attempt 1/10 2016-11-18 08:26:04,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/48f5a1870ec3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 08:26:04,899 unpacking tar archive at: mozilla-aurora-48f5a1870ec3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:05.089746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:05.090087) ========= script_repo_revision: 48f5a1870ec3974ddf717576e6e54d345e476677 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:05.090484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:05.090753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:26:05.109922) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-18 08:26:05.110564) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:05 INFO - MultiFileLogger online at 20161118 08:26:05 in /builds/slave/test 08:26:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:26:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:26:05 INFO - {'append_to_log': False, 08:26:05 INFO - 'base_work_dir': '/builds/slave/test', 08:26:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:26:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:26:05 INFO - 'branch': 'Mozilla-Aurora', 08:26:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:26:05 INFO - 'config_files': ('talos/mac_config.py',), 08:26:05 INFO - 'default_actions': ('clobber', 08:26:05 INFO - 'read-buildbot-config', 08:26:05 INFO - 'download-and-extract', 08:26:05 INFO - 'populate-webroot', 08:26:05 INFO - 'create-virtualenv', 08:26:05 INFO - 'install', 08:26:05 INFO - 'run-tests'), 08:26:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:26:05 INFO - 'download_minidump_stackwalk': True, 08:26:05 INFO - 'download_symbols': 'ondemand', 08:26:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:26:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:26:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:26:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:26:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:26:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:26:05 INFO - 'installer_path': 'installer.exe', 08:26:05 INFO - 'log_level': 'info', 08:26:05 INFO - 'log_name': 'talos', 08:26:05 INFO - 'log_to_console': True, 08:26:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:26:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:26:05 INFO - 'opt_config_files': (), 08:26:05 INFO - 'pip_index': False, 08:26:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:05 INFO - 'cmd': ('bash', 08:26:05 INFO - '-c', 08:26:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:05 INFO - 'enabled': True, 08:26:05 INFO - 'halt_on_failure': False, 08:26:05 INFO - 'name': 'check_screen_resolution'},), 08:26:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:26:05 INFO - 'cmd': ('bash', 08:26:05 INFO - '-c', 08:26:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:26:05 INFO - 'enabled': True, 08:26:05 INFO - 'halt_on_failure': False, 08:26:05 INFO - 'name': 'check_screen_resolution'},), 08:26:05 INFO - 'run_cmd_checks_enabled': True, 08:26:05 INFO - 'sps_profile': False, 08:26:05 INFO - 'sps_profile_interval': 0, 08:26:05 INFO - 'suite': 'dromaeojs-e10s', 08:26:05 INFO - 'system_bits': '32', 08:26:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:26:05 INFO - 'title': 't-yosemite-r7-0020', 08:26:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:26:05 INFO - 'use_talos_json': True, 08:26:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:26:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:26:05 INFO - 'work_dir': 'build'} 08:26:05 INFO - [mozharness: 2016-11-18 16:26:05.323235Z] Running clobber step. 08:26:05 INFO - Running pre-action listener: _resource_record_pre_action 08:26:05 INFO - Running main action method: clobber 08:26:05 INFO - rmtree: /builds/slave/test/build 08:26:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:26:07 INFO - Running post-action listener: _resource_record_post_action 08:26:07 INFO - [mozharness: 2016-11-18 16:26:07.641294Z] Finished clobber step (success) 08:26:07 INFO - [mozharness: 2016-11-18 16:26:07.641430Z] Running read-buildbot-config step. 08:26:07 INFO - Running pre-action listener: _resource_record_pre_action 08:26:07 INFO - Running main action method: read_buildbot_config 08:26:07 INFO - Using buildbot properties: 08:26:07 INFO - { 08:26:07 INFO - "project": "", 08:26:07 INFO - "product": "firefox", 08:26:07 INFO - "script_repo_revision": "production", 08:26:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:26:07 INFO - "repository": "", 08:26:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:26:07 INFO - "buildid": "20161118060928", 08:26:07 INFO - "pgo_build": "False", 08:26:07 INFO - "basedir": "/builds/slave/test", 08:26:07 INFO - "buildnumber": 23, 08:26:07 INFO - "slavename": "t-yosemite-r7-0020", 08:26:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:26:07 INFO - "platform": "yosemite_r7", 08:26:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:26:07 INFO - "branch": "mozilla-aurora", 08:26:07 INFO - "repo_path": "releases/mozilla-aurora", 08:26:07 INFO - "revision": "48f5a1870ec3974ddf717576e6e54d345e476677", 08:26:07 INFO - "stage_platform": "macosx64", 08:26:07 INFO - "builduid": "6c0ad3f43e204c4f8622f086657268d7", 08:26:07 INFO - "slavebuilddir": "test" 08:26:07 INFO - } 08:26:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:26:07 INFO - Running post-action listener: _resource_record_post_action 08:26:07 INFO - [mozharness: 2016-11-18 16:26:07.644752Z] Finished read-buildbot-config step (success) 08:26:07 INFO - [mozharness: 2016-11-18 16:26:07.644881Z] Running download-and-extract step. 08:26:07 INFO - Running pre-action listener: _resource_record_pre_action 08:26:07 INFO - Running main action method: download_and_extract 08:26:07 INFO - mkdir: /builds/slave/test/build/tests 08:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:07 INFO - trying https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:26:07 INFO - Downloading https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:26:08 INFO - Downloaded 1199 bytes. 08:26:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:26:08 INFO - Using the following test package requirements: 08:26:08 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:26:08 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:26:08 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:26:08 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'jsshell-mac.zip'], 08:26:08 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:26:08 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:26:08 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:26:08 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:26:08 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:26:08 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:26:08 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:26:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:26:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:26:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:26:08 INFO - Fetch https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:26:09 INFO - Http code: 200 08:26:09 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 08:26:09 INFO - x-amz-cf-id: vtQteEJSKzzKysVTPJaj1fIk62UY8ZFKn5367vzkN6P4rwmuivemCA== 08:26:09 INFO - x-amz-version-id: _Ytz6t173q9Sqky9B0Au8cEs0Ddpkoat 08:26:09 INFO - Expected file size: 16274875 08:26:09 INFO - Obtained file size: 16274875 08:26:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:26:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:26:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:26:16 INFO - Fetch https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:26:16 INFO - Http code: 200 08:26:16 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 08:26:16 INFO - x-amz-cf-id: vbAzHbtTiMNrvissGjNGqKq43Y7t6122BPMWb3_Nd0Laxo0XDd1ZDA== 08:26:16 INFO - x-amz-version-id: _Ytz6t173q9Sqky9B0Au8cEs0Ddpkoat 08:26:16 INFO - Expected file size: 16274875 08:26:16 INFO - Obtained file size: 16274875 08:26:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:26:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:26:23 INFO - Fetch https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:26:23 INFO - Http code: 200 08:26:23 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 08:26:23 INFO - x-amz-cf-id: FfFYDvbxjeQKDyT1Vab3kPaWdxf4UJfCB6kULgd4BpovG1GhKDjtVA== 08:26:23 INFO - x-amz-version-id: 5.ZmqO3qmRFWm_J2WzOfqREoz2h6fsM1 08:26:24 INFO - Expected file size: 14409038 08:26:24 INFO - Obtained file size: 14409038 08:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:25 INFO - trying https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:26:25 INFO - Downloading https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:26:27 INFO - Downloaded 114500549 bytes. 08:26:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:26:27 INFO - mkdir: /builds/slave/test/properties 08:26:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:26:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:26:27 INFO - Contents: 08:26:27 INFO - build_url:https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:26:28 INFO - Running post-action listener: _resource_record_post_action 08:26:28 INFO - Running post-action listener: set_extra_try_arguments 08:26:28 INFO - [mozharness: 2016-11-18 16:26:28.591515Z] Finished download-and-extract step (success) 08:26:28 INFO - [mozharness: 2016-11-18 16:26:28.591622Z] Running populate-webroot step. 08:26:28 INFO - Running pre-action listener: _resource_record_pre_action 08:26:28 INFO - Running main action method: populate_webroot 08:26:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:26:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:26:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:26:28 INFO - '--tppagecycles', 08:26:28 INFO - '7'], 08:26:28 INFO - 'tests': ['tsvgm']}}, 08:26:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:26:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:26:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:26:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:26:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:26:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['damp', 'tps']}, 08:26:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'tests': ['damp', 'tps']}, 08:26:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['dromaeo_dom']}, 08:26:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:26:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['basic_compositor_video']}, 08:26:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:26:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['a11yr', 08:26:28 INFO - 'ts_paint', 08:26:28 INFO - 'tpaint', 08:26:28 INFO - 'sessionrestore', 08:26:28 INFO - 'sessionrestore_no_auto_restore', 08:26:28 INFO - 'tabpaint']}, 08:26:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:26:28 INFO - 'ts_paint', 08:26:28 INFO - 'tpaint', 08:26:28 INFO - 'sessionrestore', 08:26:28 INFO - 'sessionrestore_no_auto_restore', 08:26:28 INFO - 'tabpaint']}, 08:26:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:26:28 INFO - 'ts_paint', 08:26:28 INFO - 'tpaint', 08:26:28 INFO - 'sessionrestore', 08:26:28 INFO - 'sessionrestore_no_auto_restore', 08:26:28 INFO - 'tabpaint']}, 08:26:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:26:28 INFO - 'ts_paint', 08:26:28 INFO - 'tpaint', 08:26:28 INFO - 'sessionrestore', 08:26:28 INFO - 'sessionrestore_no_auto_restore', 08:26:28 INFO - 'tabpaint']}, 08:26:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['a11yr', 08:26:28 INFO - 'ts_paint', 08:26:28 INFO - 'tpaint', 08:26:28 INFO - 'sessionrestore', 08:26:28 INFO - 'sessionrestore_no_auto_restore', 08:26:28 INFO - 'tabpaint']}, 08:26:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['a11yr', 08:26:28 INFO - 'ts_paint', 08:26:28 INFO - 'tpaint', 08:26:28 INFO - 'sessionrestore', 08:26:28 INFO - 'sessionrestore_no_auto_restore', 08:26:28 INFO - 'tabpaint']}, 08:26:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['tsvgx', 08:26:28 INFO - 'tsvgr_opacity', 08:26:28 INFO - 'tart', 08:26:28 INFO - 'tscrollx', 08:26:28 INFO - 'cart']}, 08:26:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:26:28 INFO - 'tsvgr_opacity', 08:26:28 INFO - 'tart', 08:26:28 INFO - 'tscrollx', 08:26:28 INFO - 'cart']}, 08:26:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'talos_options': ['--disable-e10s'], 08:26:28 INFO - 'tests': ['tp5o']}, 08:26:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'tests': ['tp5o']}, 08:26:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'talos_options': ['--disable-e10s', 08:26:28 INFO - '--xperf_path', 08:26:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:28 INFO - 'tests': ['tp5n']}, 08:26:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:26:28 INFO - 'talos_options': ['--xperf_path', 08:26:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:26:28 INFO - 'tests': ['tp5n']}}, 08:26:28 INFO - 'talos.zip': {'path': '', 08:26:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:26:28 INFO - Running post-action listener: _resource_record_post_action 08:26:28 INFO - [mozharness: 2016-11-18 16:26:28.609716Z] Finished populate-webroot step (success) 08:26:28 INFO - [mozharness: 2016-11-18 16:26:28.609819Z] Running create-virtualenv step. 08:26:28 INFO - Running pre-action listener: _resource_record_pre_action 08:26:28 INFO - Running main action method: create_virtualenv 08:26:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:26:28 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 08:26:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:26:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:26:28 INFO - Using real prefix '/tools/python27' 08:26:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:26:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:26:32 INFO - Installing pip.................done. 08:26:32 INFO - Return code: 0 08:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:26:32 INFO - Reading from file tmpfile_stdout 08:26:32 INFO - Output received: 08:26:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:26:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:26:32 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')]} 08:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:32 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')]} 08:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:32 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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:32 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 08:26:32 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 08:26:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:32 INFO - 'HOME': '/Users/cltbld', 08:26:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:32 INFO - 'LOGNAME': 'cltbld', 08:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:32 INFO - 'MOZ_NO_REMOTE': '1', 08:26:32 INFO - 'NO_EM_RESTART': '1', 08:26:32 INFO - 'PAGER': '/bin/cat', 08:26:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:32 INFO - 'PWD': '/builds/slave/test', 08:26:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:32 INFO - 'SHELL': '/bin/bash', 08:26:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:32 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:32 INFO - 'USER': 'cltbld', 08:26:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:32 INFO - 'XPC_FLAGS': '0x0', 08:26:32 INFO - 'XPC_SERVICE_NAME': '0', 08:26:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:32 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 08:26:32 INFO - Cleaning up... 08:26:32 INFO - Return code: 0 08:26:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:26:32 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')]} 08:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:32 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')]} 08:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:32 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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:32 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 08:26:32 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 08:26:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:32 INFO - 'HOME': '/Users/cltbld', 08:26:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:32 INFO - 'LOGNAME': 'cltbld', 08:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:32 INFO - 'MOZ_NO_REMOTE': '1', 08:26:32 INFO - 'NO_EM_RESTART': '1', 08:26:32 INFO - 'PAGER': '/bin/cat', 08:26:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:32 INFO - 'PWD': '/builds/slave/test', 08:26:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:32 INFO - 'SHELL': '/bin/bash', 08:26:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:32 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:32 INFO - 'USER': 'cltbld', 08:26:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:32 INFO - 'XPC_FLAGS': '0x0', 08:26:32 INFO - 'XPC_SERVICE_NAME': '0', 08:26:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:33 INFO - Downloading/unpacking psutil>=3.1.1 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:26:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:36 INFO - Installing collected packages: psutil 08:26:36 INFO - Running setup.py install for psutil 08:26:36 INFO - building 'psutil._psutil_osx' extension 08:26:36 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 INFO - building 'psutil._psutil_posix' extension 08:26:37 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 08:26:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:26:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:26:37 INFO - ^ 08:26:37 INFO - 1 warning generated. 08:26:37 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 08:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:26:37 INFO - Successfully installed psutil 08:26:37 INFO - Cleaning up... 08:26:37 INFO - Return code: 0 08:26:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:37 INFO - 'HOME': '/Users/cltbld', 08:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:37 INFO - 'LOGNAME': 'cltbld', 08:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:37 INFO - 'MOZ_NO_REMOTE': '1', 08:26:37 INFO - 'NO_EM_RESTART': '1', 08:26:37 INFO - 'PAGER': '/bin/cat', 08:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:37 INFO - 'PWD': '/builds/slave/test', 08:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:37 INFO - 'SHELL': '/bin/bash', 08:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:37 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:37 INFO - 'USER': 'cltbld', 08:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:37 INFO - 'XPC_FLAGS': '0x0', 08:26:37 INFO - 'XPC_SERVICE_NAME': '0', 08:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:37 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 08:26:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:26:40 INFO - Installing collected packages: mozsystemmonitor 08:26:40 INFO - Running setup.py install for mozsystemmonitor 08:26:40 INFO - Successfully installed mozsystemmonitor 08:26:40 INFO - Cleaning up... 08:26:40 INFO - Return code: 0 08:26:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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', '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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:26: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 jsonschema==2.5.1 08:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:40 INFO - 'HOME': '/Users/cltbld', 08:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:40 INFO - 'LOGNAME': 'cltbld', 08:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:40 INFO - 'MOZ_NO_REMOTE': '1', 08:26:40 INFO - 'NO_EM_RESTART': '1', 08:26:40 INFO - 'PAGER': '/bin/cat', 08:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:40 INFO - 'PWD': '/builds/slave/test', 08:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:40 INFO - 'SHELL': '/bin/bash', 08:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:40 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:40 INFO - 'USER': 'cltbld', 08:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:40 INFO - 'XPC_FLAGS': '0x0', 08:26:40 INFO - 'XPC_SERVICE_NAME': '0', 08:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:41 INFO - Downloading/unpacking jsonschema==2.5.1 08:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:26:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26: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 08:26:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:26:43 INFO - warning: no files found matching '*.txt' 08:26:43 INFO - no previously-included directories found matching 'build' 08:26:43 INFO - no previously-included directories found matching 'dist' 08:26:43 INFO - no previously-included directories found matching '.git*' 08:26:43 INFO - Installing collected packages: jsonschema, functools32 08:26:44 INFO - Running setup.py install for functools32 08:26:44 INFO - warning: no files found matching '*.txt' 08:26:44 INFO - no previously-included directories found matching 'build' 08:26:44 INFO - no previously-included directories found matching 'dist' 08:26:44 INFO - no previously-included directories found matching '.git*' 08:26:44 INFO - Successfully installed jsonschema functools32 08:26:44 INFO - Cleaning up... 08:26:44 INFO - Return code: 0 08:26:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:44 INFO - 'HOME': '/Users/cltbld', 08:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:44 INFO - 'LOGNAME': 'cltbld', 08:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:44 INFO - 'MOZ_NO_REMOTE': '1', 08:26:44 INFO - 'NO_EM_RESTART': '1', 08:26:44 INFO - 'PAGER': '/bin/cat', 08:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:44 INFO - 'PWD': '/builds/slave/test', 08:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:44 INFO - 'SHELL': '/bin/bash', 08:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:44 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:44 INFO - 'USER': 'cltbld', 08:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:44 INFO - 'XPC_FLAGS': '0x0', 08:26:44 INFO - 'XPC_SERVICE_NAME': '0', 08:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:26:44 INFO - Cleaning up... 08:26:44 INFO - Return code: 0 08:26:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:26:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:44 INFO - 'HOME': '/Users/cltbld', 08:26:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:44 INFO - 'LOGNAME': 'cltbld', 08:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:44 INFO - 'MOZ_NO_REMOTE': '1', 08:26:44 INFO - 'NO_EM_RESTART': '1', 08:26:44 INFO - 'PAGER': '/bin/cat', 08:26:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:44 INFO - 'PWD': '/builds/slave/test', 08:26:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:44 INFO - 'SHELL': '/bin/bash', 08:26:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:44 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:44 INFO - 'USER': 'cltbld', 08:26:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:44 INFO - 'XPC_FLAGS': '0x0', 08:26:44 INFO - 'XPC_SERVICE_NAME': '0', 08:26:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:26:44 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 08:26:44 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 08:26:44 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 08:26:44 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 08:26:44 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 08:26:44 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 08:26:47 INFO - Downloading blobuploader-1.2.4.tar.gz 08:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:26:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:26:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:48 INFO - Downloading docopt-0.6.1.tar.gz 08:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:26:48 INFO - Installing collected packages: blobuploader, requests, docopt 08:26:48 INFO - Running setup.py install for blobuploader 08:26:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:26:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:26:48 INFO - Running setup.py install for requests 08:26:49 INFO - Running setup.py install for docopt 08:26:49 INFO - Successfully installed blobuploader requests docopt 08:26:49 INFO - Cleaning up... 08:26:49 INFO - Return code: 0 08:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26: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')]} 08:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26: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')]} 08:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:50 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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:50 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 08:26:50 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 08:26:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:50 INFO - 'HOME': '/Users/cltbld', 08:26:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:50 INFO - 'LOGNAME': 'cltbld', 08:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:50 INFO - 'MOZ_NO_REMOTE': '1', 08:26:50 INFO - 'NO_EM_RESTART': '1', 08:26:50 INFO - 'PAGER': '/bin/cat', 08:26:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:50 INFO - 'PWD': '/builds/slave/test', 08:26:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:50 INFO - 'SHELL': '/bin/bash', 08:26:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:50 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:50 INFO - 'USER': 'cltbld', 08:26:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:50 INFO - 'XPC_FLAGS': '0x0', 08:26:50 INFO - 'XPC_SERVICE_NAME': '0', 08:26:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:50 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-wDh5cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:50 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-3i4m5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:50 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-I_jKe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:50 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-OXevky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:50 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-x8Bo4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:50 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-joT3v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EbO9iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-cnYRHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-wKtJDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-8MgbmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gXqCJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-0YQDDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-LZNZL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-x5wg51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_pzV4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:51 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-YBne5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:52 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Abw97t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:26:52 INFO - Running setup.py install for manifestparser 08:26:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:26:52 INFO - Running setup.py install for mozcrash 08:26:52 INFO - Running setup.py install for mozdebug 08:26:52 INFO - Running setup.py install for mozdevice 08:26:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:26:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:26:52 INFO - Running setup.py install for mozfile 08:26:52 INFO - Running setup.py install for mozhttpd 08:26:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Running setup.py install for mozinfo 08:26:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Running setup.py install for mozInstall 08:26:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Running setup.py install for mozleak 08:26:53 INFO - Running setup.py install for mozlog 08:26:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Running setup.py install for moznetwork 08:26:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:26:53 INFO - Running setup.py install for mozprocess 08:26:53 INFO - Running setup.py install for mozprofile 08:26:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:26:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:26:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:26:54 INFO - Running setup.py install for mozrunner 08:26:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:26:54 INFO - Running setup.py install for mozscreenshot 08:26:54 INFO - Running setup.py install for moztest 08:26:54 INFO - Running setup.py install for mozversion 08:26:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:26:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:26:54 INFO - Cleaning up... 08:26:54 INFO - Return code: 0 08:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:26:55 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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:26:55 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 08:26:55 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 08:26:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:26:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:26:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:26:55 INFO - 'HOME': '/Users/cltbld', 08:26:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:26:55 INFO - 'LOGNAME': 'cltbld', 08:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:26:55 INFO - 'MOZ_NO_REMOTE': '1', 08:26:55 INFO - 'NO_EM_RESTART': '1', 08:26:55 INFO - 'PAGER': '/bin/cat', 08:26:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:26:55 INFO - 'PWD': '/builds/slave/test', 08:26:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:26:55 INFO - 'SHELL': '/bin/bash', 08:26:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:26:55 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:26:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:26:55 INFO - 'USER': 'cltbld', 08:26:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:26:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:26:55 INFO - 'XPC_FLAGS': '0x0', 08:26:55 INFO - 'XPC_SERVICE_NAME': '0', 08:26:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PeWGNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:26:55 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)) 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-ts7AYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-1exxVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:26:55 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)) 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-jagZOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:26:55 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)) 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-UqB4Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:26:55 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)) 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-csPoDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:26:55 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)) 08:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:26:55 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-gEj3ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-nrTEbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Fx3ktZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-MBgXzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-KmN2oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_HBf5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-stPsqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-pY5nmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-5g2adi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:26:56 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)) 08:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:26:56 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-uBpZT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:26:57 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)) 08:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:26:57 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-azf4hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:26:57 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)) 08:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:26:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:26:57 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)) 08:26:57 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)) 08:26:57 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)) 08:26:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:00 INFO - Downloading blessings-1.6.tar.gz 08:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:00 INFO - Installing collected packages: blessings 08:27:00 INFO - Running setup.py install for blessings 08:27:00 INFO - Successfully installed blessings 08:27:00 INFO - Cleaning up... 08:27:00 INFO - Return code: 0 08:27:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:00 INFO - Reading from file tmpfile_stdout 08:27:00 INFO - Current package versions: 08:27:00 INFO - blessings == 1.6 08:27:00 INFO - blobuploader == 1.2.4 08:27:00 INFO - docopt == 0.6.1 08:27:00 INFO - functools32 == 3.2.3-2 08:27:00 INFO - jsonschema == 2.5.1 08:27:00 INFO - manifestparser == 1.1 08:27:00 INFO - mozInstall == 1.12 08:27:00 INFO - mozcrash == 1.0 08:27:00 INFO - mozdebug == 0.1 08:27:00 INFO - mozdevice == 0.48 08:27:00 INFO - mozfile == 1.2 08:27:00 INFO - mozhttpd == 0.7 08:27:00 INFO - mozinfo == 0.9 08:27:00 INFO - mozleak == 0.1 08:27:00 INFO - mozlog == 3.4 08:27:00 INFO - moznetwork == 0.27 08:27:00 INFO - mozprocess == 0.23 08:27:00 INFO - mozprofile == 0.28 08:27:00 INFO - mozrunner == 6.13 08:27:00 INFO - mozscreenshot == 0.1 08:27:00 INFO - mozsystemmonitor == 0.3 08:27:00 INFO - moztest == 0.7 08:27:00 INFO - mozversion == 1.4 08:27:00 INFO - psutil == 3.1.1 08:27:00 INFO - requests == 1.2.3 08:27:00 INFO - wsgiref == 0.1.2 08:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:27:00 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')]} 08:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:00 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')]} 08:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:00 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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:27:00 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 08:27:00 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 08:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:00 INFO - 'HOME': '/Users/cltbld', 08:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:00 INFO - 'LOGNAME': 'cltbld', 08:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:00 INFO - 'MOZ_NO_REMOTE': '1', 08:27:00 INFO - 'NO_EM_RESTART': '1', 08:27:00 INFO - 'PAGER': '/bin/cat', 08:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:00 INFO - 'PWD': '/builds/slave/test', 08:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:00 INFO - 'SHELL': '/bin/bash', 08:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:27:00 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:00 INFO - 'USER': 'cltbld', 08:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:00 INFO - 'XPC_FLAGS': '0x0', 08:27:00 INFO - 'XPC_SERVICE_NAME': '0', 08:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 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)) 08:27:00 INFO - Cleaning up... 08:27:00 INFO - Return code: 0 08:27:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:27:00 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')]} 08:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:00 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')]} 08:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:00 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 0x107aeb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a61570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc63ca64f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, '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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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 08:27:00 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 08:27:00 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 08:27:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:27:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:00 INFO - 'HOME': '/Users/cltbld', 08:27:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:00 INFO - 'LOGNAME': 'cltbld', 08:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:00 INFO - 'MOZ_NO_REMOTE': '1', 08:27:00 INFO - 'NO_EM_RESTART': '1', 08:27:00 INFO - 'PAGER': '/bin/cat', 08:27:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:00 INFO - 'PWD': '/builds/slave/test', 08:27:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:00 INFO - 'SHELL': '/bin/bash', 08:27:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:27:00 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:27:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:00 INFO - 'USER': 'cltbld', 08:27:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:00 INFO - 'XPC_FLAGS': '0x0', 08:27:00 INFO - 'XPC_SERVICE_NAME': '0', 08:27:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:27:01 INFO - Cleaning up... 08:27:01 INFO - Return code: 0 08:27:01 INFO - Running post-action listener: _resource_record_post_action 08:27:01 INFO - Running post-action listener: _start_resource_monitoring 08:27:01 INFO - Starting resource monitoring. 08:27:01 INFO - [mozharness: 2016-11-18 16:27:01.272816Z] Finished create-virtualenv step (success) 08:27:01 INFO - [mozharness: 2016-11-18 16:27:01.273860Z] Running install step. 08:27:01 INFO - Running pre-action listener: _resource_record_pre_action 08:27:01 INFO - Running main action method: install 08:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:01 INFO - Reading from file tmpfile_stdout 08:27:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:27:01 INFO - Reading from file tmpfile_stdout 08:27:01 INFO - Output received: 08:27:01 INFO - Usage: mozinstall [options] installer 08:27:01 INFO - Options: 08:27:01 INFO - -h, --help show this help message and exit 08:27:01 INFO - -d DEST, --destination=DEST 08:27:01 INFO - Directory to install application into. [default: 08:27:01 INFO - "/builds/slave/test"] 08:27:01 INFO - --app=APP Application being installed. [default: firefox] 08:27:01 INFO - mkdir: /builds/slave/test/build/application 08:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:27:33 INFO - Reading from file tmpfile_stdout 08:27:33 INFO - Output received: 08:27:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:27:33 INFO - Running post-action listener: _resource_record_post_action 08:27:33 INFO - [mozharness: 2016-11-18 16:27:33.419409Z] Finished install step (success) 08:27:33 INFO - [mozharness: 2016-11-18 16:27:33.419565Z] Running run-tests step. 08:27:33 INFO - Running pre-action listener: _resource_record_pre_action 08:27:33 INFO - Running main action method: run_tests 08:27:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:33 INFO - 2016-11-18 08:27:33.434 screenresolution[1624:7808] starting screenresolution argv=screenresolution get 08:27:33 INFO - 2016-11-18 08:27:33.436 screenresolution[1624:7808] Display 0: 1600x1200x32@60 08:27:33 INFO - 2016-11-18 08:27:33.442 screenresolution[1625:7810] starting screenresolution argv=screenresolution list 08:27:33 INFO - Available Modes on Display 0 08:27:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:33 INFO - Intel Iris: 08:27:33 INFO - Chipset Model: Intel Iris 08:27:33 INFO - Type: GPU 08:27:33 INFO - Bus: Built-In 08:27:33 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:33 INFO - Vendor: Intel (0x8086) 08:27:33 INFO - Device ID: 0x0a2e 08:27:33 INFO - Revision ID: 0x0009 08:27:33 INFO - Displays: 08:27:33 INFO - Display: 08:27:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:33 INFO - Display Serial Number: 1600x1200 60 08:27:33 INFO - Main Display: Yes 08:27:33 INFO - Mirror: Off 08:27:33 INFO - Online: Yes 08:27:33 INFO - Rotation: Supported 08:27:33 INFO - Return code: 0 08:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:27:33 INFO - Python 2.7.3 08:27:33 INFO - Return code: 0 08:27:33 INFO - grabbing minidump binary from tooltool 08:27: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')]} 08:27:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078ffd30>, '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 0x107765db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078f7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:27:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:27:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:27:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:27:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:27:33 INFO - Return code: 0 08:27:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:27:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:27:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:27:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:27:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 08:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 08:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nd4n7aQ3Fo/Render', 08:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:27:33 INFO - 'HOME': '/Users/cltbld', 08:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:27:33 INFO - 'LOGNAME': 'cltbld', 08:27:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:27:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:33 INFO - 'MOZ_NO_REMOTE': '1', 08:27:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:27:33 INFO - 'NO_EM_RESTART': '1', 08:27:33 INFO - 'PAGER': '/bin/cat', 08:27:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:33 INFO - 'PWD': '/builds/slave/test', 08:27:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:27:33 INFO - 'SHELL': '/bin/bash', 08:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZIu2gj7B2l/Listeners', 08:27:33 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 08:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:27:33 INFO - 'USER': 'cltbld', 08:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:33 INFO - 'XPC_FLAGS': '0x0', 08:27:33 INFO - 'XPC_SERVICE_NAME': '0', 08:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:27:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 08:27:34 INFO - mozversion application_buildid: 20161118060928 08:27:34 INFO - mozversion application_changeset: 48f5a1870ec3974ddf717576e6e54d345e476677 08:27:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:27:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:27:34 INFO - mozversion application_name: Firefox 08:27:34 INFO - mozversion application_remotingname: firefox-dev 08:27:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:27:34 INFO - mozversion application_vendor: Mozilla 08:27:34 INFO - mozversion application_version: 52.0a2 08:27:34 INFO - mozversion platform_buildid: 20161118060928 08:27:34 INFO - mozversion platform_changeset: 48f5a1870ec3974ddf717576e6e54d345e476677 08:27:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:27:34 INFO - mozversion platform_version: 52.0a2 08:27:34 INFO - using testdate: 1479486454 08:27:34 INFO - actual date: 1479486454 08:27:34 INFO - starting webserver on 'localhost:49241' 08:27:34 INFO - SUITE-START | Running 2 tests 08:27:34 INFO - TEST-START | dromaeo_css 08:27:34 INFO - operating with platform_type : mac_ 08:27:34 INFO - Initialising browser for dromaeo_css test... 08:27:34 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpEdSz8g/profile http://localhost:49241/getInfo.html) 08:27:35 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:27:36 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 08:27:36 INFO - PROCESS | 1635 | colorDepth:24 08:27:36 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 08:27:36 INFO - PROCESS | 1635 | __metrics 08:27:36 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 08:27:37 INFO - TEST-INFO | 1635: exit 0 08:27:37 INFO - Browser initialized. 08:27:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:27:37 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpEdSz8g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:50 INFO - PROCESS | 1638 | RSS: Main: 224161792 08:27:50 INFO - PROCESS | 1638 | 08:28:39 INFO - PROCESS | 1638 | 1479486519691 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] 08:30:52 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:30:54 INFO - PROCESS | 1638 | RSS: Main: 235466752 08:30:54 INFO - PROCESS | 1638 | 08:33:56 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:33:57 INFO - PROCESS | 1638 | RSS: Main: 244756480 08:33:57 INFO - PROCESS | 1638 | 08:36:59 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:36:59 INFO - PROCESS | 1638 | RSS: Main: 247730176 08:36:59 INFO - PROCESS | 1638 | 08:40:01 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:40:02 INFO - PROCESS | 1638 | RSS: Main: 247791616 08:40:02 INFO - PROCESS | 1638 | 08:43:05 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:43:05 INFO - PROCESS | 1638 | RSS: Main: 251211776 08:43:05 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:46:08 INFO - PROCESS | 1638 | RSS: Main: 252641280 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | __start_tp_report 08:46:08 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 08:46:08 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 08:46:08 INFO - PROCESS | 1638 | |i|pagename|runs| 08:46:08 INFO - PROCESS | 1638 | |0;dojo.html;3372.2412457197133;3387.407203739345;3388.2207092368753;3410.982945085275;3425.79445233286;4641.9767901160485;5641.182028605855;5677.744501497432;5693.28833895763;5701.401352857953;5634.436556344363;5711.71441427929;5714.857128571788;5766.567507436948;5791.971040144804;5155.510226528474;5185.325907632003;5204.401493828202;5215.713135777531;5269.683818970855;4204.642605378546;5152.613553983466;5258.605604579653;5295.311609490761;5316.548093412045;5075.492450754932;5115;5159;5168.948310516903;5226.712530810804;5104.770285337168;5112.667676601046;5120.411152717448;5142.820001299974;5223.71269580173;5109.744512774347;5111.1566591512355;5151.948480515184;5200.843974680765;5224.686518808883;4887.755612219375;5423.566114710814;5446.284420407559;5534.08687566551;5667.4332566743;5990.520758339322;5992.9700351498395;5997.970010149965;6070.089486577004;6074.028155495143;6132.202813634199;6132.601380910227;6142.78500252489;6158.5381096417495;6176.907346389808;5631.577631677641;5669.688167150764;5716.5998380113;5732.942670573324;5779.624324418899;6176.81469555914;6242.563020588515;6250.843728906813;6276.215473065867;6289.433950944437;6002.069679199731;6149.385061493815;6157.538184636171;6161.661108639068;6172.259328880563;4168.062186008185;4841.564259216688;5614.382417934024;5709.429057094258;6236;5115.488451154929;6113.32428171423;6127.448529632355;6133.233345831771;6142.692865356804;5073.771680274396;6194.194754681863;6199;6216.751329946842;6225.564210505312;4845.854624361275;4870.318155458239;4919.877003074952;4921.188003979303;4957.380327459067;3619.9819000905354;3794.886153415402;4290.420793192941;4336.718113322624;4367.606915377632;5913.172155898178;5917.704114794243;5927.436893495111;5931.13998470228;5984.910226346608;6118.785842495491;6130.948521380002;6169.81490555284;6276.959988003917;6320.178376810985;5923.17075609415;5925.259342582177;5950.494207992283;6027.849303767353;6049.818505444844;5292.576593872481;5353.86615334612;5361.169018802092;5365.38298095724;5394.460553944574;6168.228971378578;6222.253329600568;6224;6240.968795155995;6242.3133455320785;6179.783707570214;6187.969060154671;6201.193844800147;6216.689165541615;6222.315545289924;6299.937000629935;6319.178506794087;6322.905156422566;6356.841078973062;6368.076628888878;6041.909371359521;6062.545309101747;6084.939150608438;6092.786752463642;6104.359042300494;5906.940930590639;6144.648177400964;6162.445379915829;6162.969185154046;6183.134361189527;4793.520647935178;6052.878942421215;6092.116643086816;6114;6117.96941015292;6093.939060609515;6096.756129754937;6112.969435152796;6144.754209831557;6147.047207682637;5674.205611214516;5820.94179058204;5827.388124246893;5863.941360586339;5879.647221166743;4719.764011799328;6101.237345331833;6107.735039974475;6117.449429551184;6121.540884433596;5828.562857785768;5915.881682366243;5950.19672344228;5964;5968.791092311748 08:46:08 INFO - PROCESS | 1638 | |1;ext.html;480.3371347540398;481.4800015982738;508.40516595583176;508.6312423492968;530.1094161808161;31045.844770776144;39128.80435597825;40205.79897100518;40249.59750402499;42376.788116059455;33828.830855845685;41242.17515649685;41336.72648004359;41679.79160104203;41799;9445.905540944588;9589.328746987714;9606.75983100421;9608.039196080406;9629.951850240739;9480.81038379232;9522.523873806316;9556.474393908333;9558.139767420931;9578.664746733866;8063.798405039892;8565;8587;9438.867335919665;9542.618295268181;9240.168384845363;9572.904270957271;9578.377405468656;9585.993470685547;9591.472469014201;9423.57593908269;9527.951925288213;9530.904690953072;9535.570899309549;9540.141387275109;37207.62792372068;37248.696295629525;39406.80296598528;39747.8012609938;39822.00444988869;3335.6497567755277;3354.7316214702764;3361.058903507022;3448.637893021247;3934.881953541398;29314.706852931624;29474.115776526738;29910.252243693863;30087.398252034836;30356.937507187144;3078.415101130778;3159.9368012639848;3198.440272952224;3274.429572785376;3278.09852290622;353637;353742;355271;355295;357539;57515.71242143846;57884;57910;57966.710166448895;57994.13008804871;59781.103283450786;59983;60426.395736042075;60513.69743151256;60530;15766.211689415484;16013.359465621477;16052.876298659216;16068.116253605931;16071.116088615005;12220.205686630341;12491.188072775421;12610.621681349574;12611.49554017829;12643.925266352278;14632.561023169323;15686.215689215494;15691.686166276611;15758.212089395485;15764.842351576566;5669.518090962232;6674.833129171712;6675;6774.593524388552;6861.348171923659;862.8015556422058;1040.427764729411;1080.778440419712;1084.3385534823751;1088.1294964028746;25805.741942580335;29187;29543.19564266659;29966.850165749467;29966.850165749467;926.5413620258015;969.2682025071026;982.9164521015794;989.7575094101991;1016.1667432705111;15090.773638395432;15215.923920380548;15251.313690883937;15392.769108463383;15610.609734756496;442458;573688;608314;609744;611536;55301.72349138228;55313.44686553164;55389.723051384484;55417.44582554123;55586.888262234526;1311.4295281552554;1339.7186590816038;1357.1992524410646;1361.6936189357514;1368.6646771541036;28801.279968000967;29102.417951640426;29301.41397172087;30005.549916750828;30030.69969300279;48030;48496.272555912394;48512;48559.75720121377;48674;443456;448682;448835;449335.50664492935;451690;38135.42796857994;39386.2122757549;39558.40662390124;39566;39581.80209098936;44674.77662611666;44773;45020.32469512895;45029.09941801211;45182.54817451783;30977.845110774302;37568.43647345347;37639;37723.05692357713;38472.80763596164;37554.436683449225;37791.433128503646;38186.80906595449;38372;38621.4206786904;36156.27687446289;36468.27063458663;37243.813780932;37313.88058358253;37464.812675936446;32264.83867580647;33309;33769.83115084409;33833;33917.49123763096;21396.0371783267;25255.621165682896;25422.941020656075;25430.364240894127;25691.486170276115 08:46:08 INFO - PROCESS | 1638 | |2;jquery.html;362.69171204476197;366.25467174300303;371.7564994928322;384.34277385670504;392.21556886227546;18666.90666546667;19104.331348402808;19530.804691953075;19807.801921980776;20002.899985500087;11175.44122793859;11476.96707296343;11483.712907177325;11505.42472876355;11519.712007199823;4884.706917584947;5353.357597088336;5394.460553944614;5401.648892821954;5408.3504531118;3821.636944490283;4027.859024934128;5283.75831679555;5705.2012718219485;6047.788327408542;6058.9394106059035;6076.331603523631;6097.359777223394;6102.206713127287;6120.20437343147;6183.845403864917;6655.733770649168;6683.565568238049;6697.2967838377;6705.798826035227;5629.831105066854;5753.499589746149;5754.395788442195;5875.265591801025;5917.260342457193;12375.257484550955;12475.438605262785;12508.74982500354;12549.247045177228;17615.64768704619;2129.2547608337113;2277.6355783074628;2523.356544081266;2566.833155844864;2587.042794166152;8255.587220639005;9597.184239339664;9785.315027948047;9916.603335866557;10122.696319110439;1784.4379020608467;1866.318793640325;1890.3289332287115;1909.598984213317;1918.8752731072575;111986;114392;117918.41040794826;121052.78947210503;127126;11133.665990020312;11460.426978651034;11493.655190344303;11612.709682257842;11736.119791015708;14163;14217.431302747775;14233.861291096895;14250.144991300347;14287.57137285883;8284.171582841667;8440.577971101544;8453.619587118594;8470.195331443503;8517.233448989497;7132.609141217413;8318.958405207935;8452.112528184574;8554.01628812682;8563.357748168912;4160.750354978711;4380.189664912002;4431.601155895921;4453.198424283595;4537.1833070047705;1536.46991787833;1640.860526855207;1667.8999260044436;1859.5908900041968;1933.8646294759233;867.3018220332693;884.3897710579679;936.1247233836249;939.5490164720973;963.5808423335872;16257.756133658004;17707.645847082986;18658.626827463646;20311;20651.380458586267;720.9639518024078;768.7078910014159;819.0989911097864;933.3280038372361;945.8864936207561;10579.576816927236;11150.888491115147;11189.944050279697;11202.775944481227;11222.719432014102;603980;607108;607202;610177;611204;123494;131172;132535;139341;142864.85702714467;941.4821847983582;975.9414435133773;1005.1205195453978;1006.3961623026272;1008.2337423558002;18733.6253274931;19333.839969601868;19529;19537.804621953597;19539.21843126259;37002.44496332503;49837.75081124716;52697.94604107973;54875.45124548863;56431;73375.63312183405;76385.09037274112;80806;84557.57721211355;86171.1382886163;7444.553326800409;7711.845763084595;8040.879386809085;8046.517208967481;8187.79530511742;10154.695359139238;12530.060245481443;12653.114282000171;12819.038572106943;12988.35058247065;10942.124630029419;11025.283356581796;11086.667399978014;11205.551777928791;11237;10917.83623245636;10920.563177472812;10986.176036797431;11226.943865280622;11233.66299011031;8273.710420135507;9594.90405095968;10442.738931526772;10602.787944240918;10801.135909127408;6825.658717064028;6899.965500172467;7883.802904927423;8002.439829211899;8314.002319721672;10326.535305911402;10922.50848711794;10989.505472253608;11056;11092.445377731243 08:46:08 INFO - PROCESS | 1638 | |3;mootools.html;1462.5904746670933;1500.294861415135;1660.7544341743692;1748.4754573627908;1774.1218097041967;7629.9237007630045;7870.094939082007;8168.0606730226045;8559.572021398928;8637.697680581174;7142.642867856599;8061.395395345358;8386.496810191393;8387.993440787113;8478.57607119643;2290.3014580552926;2319.895604697784;2320.6983092197993;2321.6401457774073;2322.907083716658;2312.2022902098834;2348.5302939412186;2368.7749663781915;2374.513224788914;2379.690640216778;2173.3045425463856;2174.293354659734;2184.01719226348;2195.473086459246;2198.0987795004053;1954.6774782160926;2276.362618466832;2296.8851557422145;2323.6398358254414;2325.6046472099783;2319.1998760427628;2353.505763789606;2357.610994185957;2362.0905951208906;2364.456175079741;7441.479096463249;8461.323094152453;8533.573321333908;8543.40196186261;8564.186402291773;5017.172166592544;5251.291075704808;5262.210668399733;5267.28891599633;5290.0477913975465;3301.884434044821;3356.228067544454;3601.45978103284;3604.4593311003296;3606.0624237698125;1024.9282550221487;1028.1774580335775;1057.1278695076592;1063.9308444951052;1082.9891701082968;8679.435836670596;11037.889621103766;11109.277896936674;11118.444077796077;11122.165837562216;4492.663050271242;4572.908541829212;4659.254519276899;4682.157211701926;4705.317728929286;9546.18857397129;9584.616615335308;9626.278029147841;9631.518424078768;9689.70930872075;5228.08508511009;5231.529162375405;5240.240165176028;5242.292290540804;5247.422783493813;4263.786810659454;4283.2932566126865;4605.539446055434;4677.602403795648;4809.398825146856;3802.3535998880257;3832.2718683450057;3859.1702783901596;3913.295606790748;3918.1771827916455;1231.4273862653909;1236.1470585296117;1237.9133460657667;1238.3931873382157;1242.8446444194476;786.622421237809;874.8993865705398;897.3090720145582;901.2429559170197;922.4603606890045;5870.823875283663;5913.497352725067;5942.762289508458;6002.429769171922;6206.441420272197;863.3266052479077;880.2517859819103;888.8933328000682;898.1243287794479;925.3661242049218;3275.295811400513;3794.29805485986;3875.4961854958674;3932.783696896641;3974.4833171688074;9879.357841740408;10359;10394;10414.427206503715;10440.843387349196;8641.222289993804;10060.849087263698;10349.534270957825;10378.325408848401;10384.221183411275;6193.442590166816;6924.861502770017;8012.31895288907;8049.678012879536;8053.436259461899;5699.373068962494;5744.655320680772;5837.416258374129;5921.940780592311;6007.12896629995;7852.332551733167;9381.85927211106;9477.668281610111;9554.092361225672;9568.61725530971;9705;9753.366031207948;9821.656242031495;9869.753256168653;9872.45701486425;6805.931940680728;6991.720331186695;7189.7483588074165;7293.234210408043;7458.8508229834015;7995.360371170176;8163.551004694561;8174.100848906496;8174.427790054639;8190.754277371689;7138.892916606152;7293.927060729325;7334.266573342623;7382.741604043833;7410.703571857065;7090.468214883801;7122.715091396286;7160.713571457083;7183.066201393785;7326.9267307326245;6729.663516824237;6883.208431030495;6894.689738961859;6921.411680007054;6922.58464492132;4824.324594556695;4897.167481528078;4936.407631084149;4957.776900039579;4975.577075948585;4834.419869615669;4862.5380588844;4902.313676085422;5018.222175562793;5030.673006254582 08:46:08 INFO - PROCESS | 1638 | |4;prototype.html;293.2302705398328;298.29453342844175;307.6354519893926;308.487910069285;309.1421305876193;4819.421609438951;5099.311592934952;5265.973670131653;5363.463653634634;5424.4776179076725;4997.450280469155;5389.380221274555;5419.590906364344;5433.891322173554;5462.918056229159;3238.5304130901122;3399.4220982433044;3448.3965306071464;3984.6812255019527;4166.749995000309;3431.3823511767873;3788.867389641363;3871.522225775506;3959.247742928834;4198.244316023115;4001.4998125234347;4028.2950483665386;4062;4073.6130067643526;4085.754854708712;3204.3431096625136;3498.930021399558;4026.3557830747086;4039.515258169009;4041.1917616476676;3071.032624723205;3214.791038582508;3495.3883070462566;3496.1958749487508;3499.6675315844955;4083.7141400102005;4805.975970120127;5006.524380183877;5208.270842082112;5223.843284701465;4520.638348932111;4521.502634710179;4533.025399539115;4537.863864084083;4587.610053145453;5106.374474123377;5496.6258435391155;5525.336959564878;5545.584081193886;5617.859553511154;3678.429843374281;3766.9623303766884;3778.244351129785;3782.432635104729;3810.7523011004196;4726.558399688094;5498.835034948958;5560.888782224333;5843.123531470271;5888.791703111333;3834.2331533693373;3877.6897848172644;3879.612038796154;3902.843886244518;3911.7652940823073;3288.3423315337027;3590.2407820167928;3768.717346199046;3975.5626881043063;4006.3189257825657;4545.4545454545005;4575.084983003413;4580.923482981497;4627.722336659744;4650.4186976627925;5612.831615051473;5774.7767109662245;5779.064013555506;5828.659408336106;5838.386969368155;1094.4746521669642;1106.6016234155697;1118.5917140243753;1209.727811242481;1285.794272916329;808.6374459036542;861.7845538615346;870.6038752367657;874.3791907745572;878.0429332027992;5164.845054648366;5190.8961820764125;5212.149686861186;5238.7904483820985;5262.474012474034;5081.466446023114;5342.439043900412;5510.393856675762;5531.419200983919;5556.6943818089585;4812.542808433193;5045;5066.670666406671;5088.498892826625;5139.922901156486;2760.751532362097;2882.6684931232758;2965.851707414664;2987.5054329635;3012.4276387486307;5832.88334233313;5870.444332251956;5920.572565248228;5932.953131169739;5935.792247271324;5002.074616196015;5245.554127899171;5341.252224688546;5571.8269874748885;5718.771249149988;5081.0092032054135;5213.7914483421;5841.970790146022;5911.379305172895;5917.319508256605;5331.413544510023;5573.265911839158;5611.775528978795;5629.155626656035;5649.717514124195;4922.064807686528;5516.475934786189;5596.916046259391;5597.328320601554;5690.544756419394;5210.843674689765;5433.130699088285;5873.296743944208;5886.264216972879;5923.851903702442;3144.1641197738722;3287.934241315208;3623.8369273383287;3707.480952666575;3720.069982504374;5185.559227465707;5329.001624390853;5885.234919460443;5885.735141918538;5950.7917222896995;4749.24012158053;5314.62797604164;5623.943760562342;5773.711314434346;5784.161296612052;5214.765335559985;5709.7145142741865;5744.4829965303325;5748.223989761496;5792.855178620568;5379.757910894097;5607.859803504945;5631.746571404215;5642.971785141048;5649.604527683023;4721.032188401301;4775.6657034007285;5739.282589676291;5764.971175144097;5786.392428794916;4805.8077676892535;5620.522255608319;5632.211490391266;5652.64336559231;5703.896830391442 08:46:08 INFO - PROCESS | 1638 | |5;yui.html;593.2643522032679;689.3038031588096;690.9965450172748;747.6747614787571;792.4492477727981;11374.772504549905;14802.40790368384;14888.702225955474;14916.254187290646;14949.47676831311;13217;13269;13359.465621375157;13365.064445488819;13375.732485350287;649.4090377756243;670.1355251725269;808.5270116981573;814.6537721468382;837.392890154636;820.9917900820975;833.2375876073386;833.3874602167402;833.5707110837923;837.1628371628371;876.4128034217058;882.4749274181852;884.8716936044302;886.0386480668483;886.162576365335;870.7765589346915;874.1389731114847;878.5387671472496;879.6789171952255;882.3470631732536;538.760251687999;646.8835609590271;651.4202359899693;652.5236577298551;655.813093268421;13855.515056973058;14040.1575905446;14075.436982520687;14086.084404513675;14330.57008289753;12916.741665166737;12965.805512917314;12980.091393602452;13089.34553272342;13459.259740714257;11181.44092795357;11475.598354057567;11590.884091159065;11619.954204121585;11664.94167529157;3680.6871415929677;3722.2555488902326;3740.513733214692;3759.3233218020746;3785.091578021255;92799;96651.03348966561;96658.0334196656;97008;98953.5052324741;10514.789704205874;10728;10761.354318740901;10817.83773243402;10987.505562249718;20833.89583052075;20885.477863053242;20957.371278861658;21108.944552772606;21349.78650213509;7648.541087534654;7674.232576742281;7725.92274077252;7841.960790196013;7911.762647120596;4171.249175148441;4226.640735537452;4349.021470169187;4363.650907927358;4372.322290045048;3335.4329763940186;3424.7945123292684;3431.1936694876686;3432.8970130896114;3452.2750222453064;654.2476152424655;667.2760055339913;687.340153452691;708.777359055625;710.0166269716377;514.8532668189548;566.9291338582677;595.3064679648248;612.8192183305936;621.170737066022;8355.665773369119;8379.868717723151;9190.816183676288;9336.673216437392;9465.716028519155;545.5335687986793;560.4367610551451;624.8250489862845;649.4836604899117;681.2370145437043;3986.9202615948097;4460.174867649495;4461.866144015685;4587.770611469413;4678.532146785362;70468.2953170472;90469;98221;117652.82347176419;129200.3539982294;83931;86277;88559.55720221487;97422.5128874351;99247;55100.448995509534;56465.87068258694;77248.61375693085;88340;93863.53068234616;9162.816743664956;9714.75713107178;9781.902180978384;9919.504024798876;9954.303198776017;42749.35875961801;53933.73033134966;55875.72062139826;58311.26390374037;58334.708326458094;52837.735811320694;61346.69326653338;79559.60220198861;79854;81043.59478202571;12795.31591121424;12868.292243926673;13214;13383.598492045254;13739.519116830863;13779.931100344435;14075.788863167265;14328.211948342941;14370.928145359207;14503.854961450672;12269.815952760537;13465.663358416117;13516.25660588677;13956.511522096678;14033.298335083;13436.462541498231;13794.103383280055;14086.577402677936;14100.929495352457;14142.78785818234;12290.81563776562;12595.307258100893;13384.464621415034;13722.382492787649;13771.793423098461;10259.794804104025;10398.480075996018;10891.640005564144;10905.836412453978;11349.943250283695;9052.502112383881;11203.439828008404;11507.482163302839;11546.42267886619;11556.075513959031 08:46:08 INFO - PROCESS | 1638 | __end_tp_report 08:46:08 INFO - PROCESS | 1638 | __start_cc_report 08:46:08 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,383 08:46:08 INFO - PROCESS | 1638 | __end_cc_report 08:46:08 INFO - PROCESS | 1638 | __startTimestamp1479487568901__endTimestamp 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | ------- Summary: start ------- 08:46:08 INFO - PROCESS | 1638 | Number of tests: 6 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5638.91 Median:5917.70 stddev:683.01 (11.5%) stddev-sans-first:661.56 08:46:08 INFO - PROCESS | 1638 | Values: 3372.2 3387.4 3388.2 3411.0 3425.8 4642.0 5641.2 5677.7 5693.3 5701.4 5634.4 5711.7 5714.9 5766.6 5792.0 5155.5 5185.3 5204.4 5215.7 5269.7 4204.6 5152.6 5258.6 5295.3 5316.5 5075.5 5115.0 5159.0 5168.9 5226.7 5104.8 5112.7 5120.4 5142.8 5223.7 5109.7 5111.2 5151.9 5200.8 5224.7 4887.8 5423.6 5446.3 5534.1 5667.4 5990.5 5993.0 5998.0 6070.1 6074.0 6132.2 6132.6 6142.8 6158.5 6176.9 5631.6 5669.7 5716.6 5732.9 5779.6 6176.8 6242.6 6250.8 6276.2 6289.4 6002.1 6149.4 6157.5 6161.7 6172.3 4168.1 4841.6 5614.4 5709.4 6236.0 5115.5 6113.3 6127.4 6133.2 6142.7 5073.8 6194.2 6199.0 6216.8 6225.6 4845.9 4870.3 4919.9 4921.2 4957.4 3620.0 3794.9 4290.4 4336.7 4367.6 5913.2 5917.7 5927.4 5931.1 5984.9 6118.8 6130.9 6169.8 6277.0 6320.2 5923.2 5925.3 5950.5 6027.8 6049.8 5292.6 5353.9 5361.2 5365.4 5394.5 6168.2 6222.3 6224.0 6241.0 6242.3 6179.8 6188.0 6201.2 6216.7 6222.3 6299.9 6319.2 6322.9 6356.8 6368.1 6041.9 6062.5 6084.9 6092.8 6104.4 5906.9 6144.6 6162.4 6163.0 6183.1 4793.5 6052.9 6092.1 6114.0 6118.0 6093.9 6096.8 6113.0 6144.8 6147.0 5674.2 5820.9 5827.4 5863.9 5879.6 4719.8 6101.2 6107.7 6117.4 6121.5 5828.6 5915.9 5950.2 5964.0 5968.8 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:60476.97 Median:21660.55 stddev:124406.56 (574.3%) stddev-sans-first:124674.00 08:46:08 INFO - PROCESS | 1638 | Values: 480.3 481.5 508.4 508.6 530.1 31045.8 39128.8 40205.8 40249.6 42376.8 33828.8 41242.2 41336.7 41679.8 41799.0 9445.9 9589.3 9606.8 9608.0 9630.0 9480.8 9522.5 9556.5 9558.1 9578.7 8063.8 8565.0 8587.0 9438.9 9542.6 9240.2 9572.9 9578.4 9586.0 9591.5 9423.6 9528.0 9530.9 9535.6 9540.1 37207.6 37248.7 39406.8 39747.8 39822.0 3335.6 3354.7 3361.1 3448.6 3934.9 29314.7 29474.1 29910.3 30087.4 30356.9 3078.4 3159.9 3198.4 3274.4 3278.1 353637.0 353742.0 355271.0 355295.0 357539.0 57515.7 57884.0 57910.0 57966.7 57994.1 59781.1 59983.0 60426.4 60513.7 60530.0 15766.2 16013.4 16052.9 16068.1 16071.1 12220.2 12491.2 12610.6 12611.5 12643.9 14632.6 15686.2 15691.7 15758.2 15764.8 5669.5 6674.8 6675.0 6774.6 6861.3 862.8 1040.4 1080.8 1084.3 1088.1 25805.7 29187.0 29543.2 29966.9 29966.9 926.5 969.3 982.9 989.8 1016.2 15090.8 15215.9 15251.3 15392.8 15610.6 442458.0 573688.0 608314.0 609744.0 611536.0 55301.7 55313.4 55389.7 55417.4 55586.9 1311.4 1339.7 1357.2 1361.7 1368.7 28801.3 29102.4 29301.4 30005.5 30030.7 48030.0 48496.3 48512.0 48559.8 48674.0 443456.0 448682.0 448835.0 449335.5 451690.0 38135.4 39386.2 39558.4 39566.0 39581.8 44674.8 44773.0 45020.3 45029.1 45182.5 30977.8 37568.4 37639.0 37723.1 38472.8 37554.4 37791.4 38186.8 38372.0 38621.4 36156.3 36468.3 37243.8 37313.9 37464.8 32264.8 33309.0 33769.8 33833.0 33917.5 21396.0 25255.6 25422.9 25430.4 25691.5 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:34695.70 Median:2576.94 stddev:101712.73 (3947.0%) stddev-sans-first:101965.39 08:46:08 INFO - PROCESS | 1638 | Values: 362.7 366.3 371.8 384.3 392.2 18666.9 19104.3 19530.8 19807.8 20002.9 11175.4 11477.0 11483.7 11505.4 11519.7 4884.7 5353.4 5394.5 5401.6 5408.4 3821.6 4027.9 5283.8 5705.2 6047.8 6058.9 6076.3 6097.4 6102.2 6120.2 6183.8 6655.7 6683.6 6697.3 6705.8 5629.8 5753.5 5754.4 5875.3 5917.3 12375.3 12475.4 12508.7 12549.2 17615.6 2129.3 2277.6 2523.4 2566.8 2587.0 8255.6 9597.2 9785.3 9916.6 10122.7 1784.4 1866.3 1890.3 1909.6 1918.9 111986.0 114392.0 117918.4 121052.8 127126.0 11133.7 11460.4 11493.7 11612.7 11736.1 14163.0 14217.4 14233.9 14250.1 14287.6 8284.2 8440.6 8453.6 8470.2 8517.2 7132.6 8319.0 8452.1 8554.0 8563.4 4160.8 4380.2 4431.6 4453.2 4537.2 1536.5 1640.9 1667.9 1859.6 1933.9 867.3 884.4 936.1 939.5 963.6 16257.8 17707.6 18658.6 20311.0 20651.4 721.0 768.7 819.1 933.3 945.9 10579.6 11150.9 11189.9 11202.8 11222.7 603980.0 607108.0 607202.0 610177.0 611204.0 123494.0 131172.0 132535.0 139341.0 142864.9 941.5 975.9 1005.1 1006.4 1008.2 18733.6 19333.8 19529.0 19537.8 19539.2 37002.4 49837.8 52697.9 54875.5 56431.0 73375.6 76385.1 80806.0 84557.6 86171.1 7444.6 7711.8 8040.9 8046.5 8187.8 10154.7 12530.1 12653.1 12819.0 12988.4 10942.1 11025.3 11086.7 11205.6 11237.0 10917.8 10920.6 10986.2 11226.9 11233.7 8273.7 9594.9 10442.7 10602.8 10801.1 6825.7 6900.0 7883.8 8002.4 8314.0 10326.5 10922.5 10989.5 11056.0 11092.4 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5490.82 Median:5241.27 stddev:3009.50 (57.4%) stddev-sans-first:3002.72 08:46:08 INFO - PROCESS | 1638 | Values: 1462.6 1500.3 1660.8 1748.5 1774.1 7629.9 7870.1 8168.1 8559.6 8637.7 7142.6 8061.4 8386.5 8388.0 8478.6 2290.3 2319.9 2320.7 2321.6 2322.9 2312.2 2348.5 2368.8 2374.5 2379.7 2173.3 2174.3 2184.0 2195.5 2198.1 1954.7 2276.4 2296.9 2323.6 2325.6 2319.2 2353.5 2357.6 2362.1 2364.5 7441.5 8461.3 8533.6 8543.4 8564.2 5017.2 5251.3 5262.2 5267.3 5290.0 3301.9 3356.2 3601.5 3604.5 3606.1 1024.9 1028.2 1057.1 1063.9 1083.0 8679.4 11037.9 11109.3 11118.4 11122.2 4492.7 4572.9 4659.3 4682.2 4705.3 9546.2 9584.6 9626.3 9631.5 9689.7 5228.1 5231.5 5240.2 5242.3 5247.4 4263.8 4283.3 4605.5 4677.6 4809.4 3802.4 3832.3 3859.2 3913.3 3918.2 1231.4 1236.1 1237.9 1238.4 1242.8 786.6 874.9 897.3 901.2 922.5 5870.8 5913.5 5942.8 6002.4 6206.4 863.3 880.3 888.9 898.1 925.4 3275.3 3794.3 3875.5 3932.8 3974.5 9879.4 10359.0 10394.0 10414.4 10440.8 8641.2 10060.8 10349.5 10378.3 10384.2 6193.4 6924.9 8012.3 8049.7 8053.4 5699.4 5744.7 5837.4 5921.9 6007.1 7852.3 9381.9 9477.7 9554.1 9568.6 9705.0 9753.4 9821.7 9869.8 9872.5 6805.9 6991.7 7189.7 7293.2 7458.9 7995.4 8163.6 8174.1 8174.4 8190.8 7138.9 7293.9 7334.3 7382.7 7410.7 7090.5 7122.7 7160.7 7183.1 7326.9 6729.7 6883.2 6894.7 6921.4 6922.6 4824.3 4897.2 4936.4 4957.8 4975.6 4834.4 4862.5 4902.3 5018.2 5030.7 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4511.43 Median:5152.38 stddev:1422.87 (27.6%) stddev-sans-first:1391.19 08:46:08 INFO - PROCESS | 1638 | Values: 293.2 298.3 307.6 308.5 309.1 4819.4 5099.3 5266.0 5363.5 5424.5 4997.5 5389.4 5419.6 5433.9 5462.9 3238.5 3399.4 3448.4 3984.7 4166.7 3431.4 3788.9 3871.5 3959.2 4198.2 4001.5 4028.3 4062.0 4073.6 4085.8 3204.3 3498.9 4026.4 4039.5 4041.2 3071.0 3214.8 3495.4 3496.2 3499.7 4083.7 4806.0 5006.5 5208.3 5223.8 4520.6 4521.5 4533.0 4537.9 4587.6 5106.4 5496.6 5525.3 5545.6 5617.9 3678.4 3767.0 3778.2 3782.4 3810.8 4726.6 5498.8 5560.9 5843.1 5888.8 3834.2 3877.7 3879.6 3902.8 3911.8 3288.3 3590.2 3768.7 3975.6 4006.3 4545.5 4575.1 4580.9 4627.7 4650.4 5612.8 5774.8 5779.1 5828.7 5838.4 1094.5 1106.6 1118.6 1209.7 1285.8 808.6 861.8 870.6 874.4 878.0 5164.8 5190.9 5212.1 5238.8 5262.5 5081.5 5342.4 5510.4 5531.4 5556.7 4812.5 5045.0 5066.7 5088.5 5139.9 2760.8 2882.7 2965.9 2987.5 3012.4 5832.9 5870.4 5920.6 5933.0 5935.8 5002.1 5245.6 5341.3 5571.8 5718.8 5081.0 5213.8 5842.0 5911.4 5917.3 5331.4 5573.3 5611.8 5629.2 5649.7 4922.1 5516.5 5596.9 5597.3 5690.5 5210.8 5433.1 5873.3 5886.3 5923.9 3144.2 3287.9 3623.8 3707.5 3720.1 5185.6 5329.0 5885.2 5885.7 5950.8 4749.2 5314.6 5623.9 5773.7 5784.2 5214.8 5709.7 5744.5 5748.2 5792.9 5379.8 5607.9 5631.7 5643.0 5649.6 4721.0 4775.7 5739.3 5765.0 5786.4 4805.8 5620.5 5632.2 5652.6 5703.9 08:46:08 INFO - PROCESS | 1638 | 08:46:08 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20115.35 Median:4633.15 stddev:29187.98 (630.0%) stddev-sans-first:29233.05 08:46:08 INFO - PROCESS | 1638 | Values: 593.3 689.3 691.0 747.7 792.4 11374.8 14802.4 14888.7 14916.3 14949.5 13217.0 13269.0 13359.5 13365.1 13375.7 649.4 670.1 808.5 814.7 837.4 821.0 833.2 833.4 833.6 837.2 876.4 882.5 884.9 886.0 886.2 870.8 874.1 878.5 879.7 882.3 538.8 646.9 651.4 652.5 655.8 13855.5 14040.2 14075.4 14086.1 14330.6 12916.7 12965.8 12980.1 13089.3 13459.3 11181.4 11475.6 11590.9 11620.0 11664.9 3680.7 3722.3 3740.5 3759.3 3785.1 92799.0 96651.0 96658.0 97008.0 98953.5 10514.8 10728.0 10761.4 10817.8 10987.5 20833.9 20885.5 20957.4 21108.9 21349.8 7648.5 7674.2 7725.9 7842.0 7911.8 4171.2 4226.6 4349.0 4363.7 4372.3 3335.4 3424.8 3431.2 3432.9 3452.3 654.2 667.3 687.3 708.8 710.0 514.9 566.9 595.3 612.8 621.2 8355.7 8379.9 9190.8 9336.7 9465.7 545.5 560.4 624.8 649.5 681.2 3986.9 4460.2 4461.9 4587.8 4678.5 70468.3 90469.0 98221.0 117652.8 129200.4 83931.0 86277.0 88559.6 97422.5 99247.0 55100.4 56465.9 77248.6 88340.0 93863.5 9162.8 9714.8 9781.9 9919.5 9954.3 42749.4 53933.7 55875.7 58311.3 58334.7 52837.7 61346.7 79559.6 79854.0 81043.6 12795.3 12868.3 13214.0 13383.6 13739.5 13779.9 14075.8 14328.2 14370.9 14503.9 12269.8 13465.7 13516.3 13956.5 14033.3 13436.5 13794.1 14086.6 14100.9 14142.8 12290.8 12595.3 13384.5 13722.4 13771.8 10259.8 10398.5 10891.6 10905.8 11349.9 9052.5 11203.4 11507.5 11546.4 11556.1 08:46:08 INFO - PROCESS | 1638 | -------- Summary: end -------- 08:46:08 INFO - PROCESS | 1638 | 08:46:09 INFO - TEST-INFO | 1638: exit 0 08:46:09 INFO - TEST-OK | dromaeo_css | took 1115505ms 08:46:09 INFO - TEST-START | kraken 08:46:09 INFO - operating with platform_type : mac_ 08:46:09 INFO - Initialising browser for kraken test... 08:46:09 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpsaO2Vi/profile http://localhost:49241/getInfo.html) 08:46:11 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 08:46:12 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 08:46:12 INFO - PROCESS | 1651 | colorDepth:24 08:46:12 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 08:46:12 INFO - PROCESS | 1651 | __metrics 08:46:12 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 08:46:13 INFO - TEST-INFO | 1651: exit 0 08:46:13 INFO - Browser initialized. 08:46:13 INFO - Running cycle 1/1 for kraken test... 08:46:13 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpsaO2Vi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:25 INFO - PROCESS | 1653 | RSS: Main: 224067584 08:46:25 INFO - PROCESS | 1653 | 08:46:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:46:29 INFO - PROCESS | 1653 | RSS: Main: 236609536 08:46:29 INFO - PROCESS | 1653 | 08:46:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:46:32 INFO - PROCESS | 1653 | RSS: Main: 244191232 08:46:32 INFO - PROCESS | 1653 | 08:46:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:46:36 INFO - PROCESS | 1653 | RSS: Main: 247910400 08:46:36 INFO - PROCESS | 1653 | 08:46:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:46:38 INFO - PROCESS | 1653 | RSS: Main: 248360960 08:46:38 INFO - PROCESS | 1653 | 08:46:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:46:41 INFO - PROCESS | 1653 | RSS: Main: 248307712 08:46:41 INFO - PROCESS | 1653 | 08:46:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:46:44 INFO - PROCESS | 1653 | RSS: Main: 252125184 08:46:44 INFO - PROCESS | 1653 | 08:46:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:46:48 INFO - PROCESS | 1653 | RSS: Main: 252747776 08:46:48 INFO - PROCESS | 1653 | 08:46:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:46:52 INFO - PROCESS | 1653 | RSS: Main: 252874752 08:46:52 INFO - PROCESS | 1653 | 08:46:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:46:54 INFO - PROCESS | 1653 | RSS: Main: 251883520 08:46:54 INFO - PROCESS | 1653 | 08:46:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:46:57 INFO - PROCESS | 1653 | RSS: Main: 252002304 08:46:57 INFO - PROCESS | 1653 | 08:46:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:00 INFO - PROCESS | 1653 | RSS: Main: 251936768 08:47:00 INFO - PROCESS | 1653 | 08:47:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:03 INFO - PROCESS | 1653 | RSS: Main: 252252160 08:47:03 INFO - PROCESS | 1653 | 08:47:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:07 INFO - PROCESS | 1653 | RSS: Main: 252399616 08:47:07 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:47:09 INFO - PROCESS | 1653 | RSS: Main: 254287872 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | __start_tp_report 08:47:09 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:47:09 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:47:09 INFO - PROCESS | 1653 | |i|pagename|runs| 08:47:09 INFO - PROCESS | 1653 | |0;ai-astar;105;138;98;164;173;174;121;117;120;118 08:47:09 INFO - PROCESS | 1653 | |1;audio-beat-detection;148;115;117;188;116;134;151;146;136;149 08:47:09 INFO - PROCESS | 1653 | |2;audio-dft;196;198;196;196;198;198;196;199;203;201 08:47:09 INFO - PROCESS | 1653 | |3;audio-fft;82;60;59;85;62;60;58;58;80;58 08:47:09 INFO - PROCESS | 1653 | |4;audio-oscillator;87;70;92;74;68;71;97;99;102;91 08:47:09 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;90;87;90;85;90;85;100;86;90;87 08:47:09 INFO - PROCESS | 1653 | |6;imaging-darkroom;117;171;154;100;132;123;173;153;99;105 08:47:09 INFO - PROCESS | 1653 | |7;imaging-desaturate;78;139;136;86;87;88;91;91;88;87 08:47:09 INFO - PROCESS | 1653 | |8;json-parse-financial;56;58;56;59;59;60;60;60;60;60 08:47:09 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;69;75;71;86;79;75;70;72;74;74 08:47:09 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;84;84;87;75;97;104;84;84;92 08:47:09 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;148;147;146;146;163;177;147;136;222;194 08:47:09 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;194;177;229;237;160;234;164;222;233;172 08:47:09 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;69;75;90;94;78;68;69;70;67;69 08:47:09 INFO - PROCESS | 1653 | __end_tp_report 08:47:09 INFO - PROCESS | 1653 | __start_cc_report 08:47:09 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,998 08:47:09 INFO - PROCESS | 1653 | __end_cc_report 08:47:09 INFO - PROCESS | 1653 | __startTimestamp1479487629666__endTimestamp 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:47:09 INFO - PROCESS | 1653 | Number of tests: 14 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:132.80 Median:151.00 stddev:28.03 (18.6%) stddev-sans-first:27.86 08:47:09 INFO - PROCESS | 1653 | Values: 105.0 138.0 98.0 164.0 173.0 174.0 121.0 117.0 120.0 118.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:147.00 stddev:22.08 (15.0%) stddev-sans-first:23.23 08:47:09 INFO - PROCESS | 1653 | Values: 148.0 115.0 117.0 188.0 116.0 134.0 151.0 146.0 136.0 149.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:198.10 Median:198.00 stddev:2.38 (1.2%) stddev-sans-first:2.40 08:47:09 INFO - PROCESS | 1653 | Values: 196.0 198.0 196.0 196.0 198.0 198.0 196.0 199.0 203.0 201.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.00 stddev:11.26 (18.5%) stddev-sans-first:10.39 08:47:09 INFO - PROCESS | 1653 | Values: 82.0 60.0 59.0 85.0 62.0 60.0 58.0 58.0 80.0 58.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:89.00 stddev:13.12 (14.7%) stddev-sans-first:13.90 08:47:09 INFO - PROCESS | 1653 | Values: 87.0 70.0 92.0 74.0 68.0 71.0 97.0 99.0 102.0 91.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:88.50 stddev:4.40 (5.0%) stddev-sans-first:4.65 08:47:09 INFO - PROCESS | 1653 | Values: 90.0 87.0 90.0 85.0 90.0 85.0 100.0 86.0 90.0 87.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:132.70 Median:153.50 stddev:28.42 (18.5%) stddev-sans-first:29.57 08:47:09 INFO - PROCESS | 1653 | Values: 117.0 171.0 154.0 100.0 132.0 123.0 173.0 153.0 99.0 105.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:87.50 stddev:21.60 (24.7%) stddev-sans-first:21.78 08:47:09 INFO - PROCESS | 1653 | Values: 78.0 139.0 136.0 86.0 87.0 88.0 91.0 91.0 88.0 87.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:60.00 stddev:1.62 (2.7%) stddev-sans-first:1.36 08:47:09 INFO - PROCESS | 1653 | Values: 56.0 58.0 56.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:74.50 Median:74.50 stddev:4.97 (6.7%) stddev-sans-first:4.86 08:47:09 INFO - PROCESS | 1653 | Values: 69.0 75.0 71.0 86.0 79.0 75.0 70.0 72.0 74.0 74.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:8.13 (9.6%) stddev-sans-first:8.57 08:47:09 INFO - PROCESS | 1653 | Values: 85.0 84.0 84.0 87.0 75.0 97.0 104.0 84.0 84.0 92.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:162.60 Median:155.50 stddev:27.24 (17.5%) stddev-sans-first:28.38 08:47:09 INFO - PROCESS | 1653 | Values: 148.0 147.0 146.0 146.0 163.0 177.0 147.0 136.0 222.0 194.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.20 Median:225.50 stddev:31.86 (14.1%) stddev-sans-first:33.65 08:47:09 INFO - PROCESS | 1653 | Values: 194.0 177.0 229.0 237.0 160.0 234.0 164.0 222.0 233.0 172.0 08:47:09 INFO - PROCESS | 1653 | 08:47:09 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:72.50 stddev:9.67 (13.3%) stddev-sans-first:10.01 08:47:09 INFO - PROCESS | 1653 | Values: 69.0 75.0 90.0 94.0 78.0 68.0 69.0 70.0 67.0 69.0 08:47:09 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:47:09 INFO - PROCESS | 1653 | 08:47:10 INFO - TEST-INFO | 1653: exit 0 08:47:10 INFO - TEST-OK | kraken | took 61021ms 08:47:10 INFO - SUITE-END | took 1176s 08:47:10 INFO - Completed test suite (00:19:36) 08:47:10 INFO - javascript benchmark 08:47:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7096.959820077785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3372.2412457197133, 3387.407203739345, 3388.2207092368753, 3410.982945085275, 3425.79445233286, 4641.9767901160485, 5641.182028605855, 5677.744501497432, 5693.28833895763, 5701.401352857953, 5634.436556344363, 5711.71441427929, 5714.857128571788, 5766.567507436948, 5791.971040144804, 5155.510226528474, 5185.325907632003, 5204.401493828202, 5215.713135777531, 5269.683818970855, 4204.642605378546, 5152.613553983466, 5258.605604579653, 5295.311609490761, 5316.548093412045, 5075.492450754932, 5115.0, 5159.0, 5168.948310516903, 5226.712530810804, 5104.770285337168, 5112.667676601046, 5120.411152717448, 5142.820001299974, 5223.71269580173, 5109.744512774347, 5111.1566591512355, 5151.948480515184, 5200.843974680765, 5224.686518808883, 4887.755612219375, 5423.566114710814, 5446.284420407559, 5534.08687566551, 5667.4332566743, 5990.520758339322, 5992.9700351498395, 5997.970010149965, 6070.089486577004, 6074.028155495143, 6132.202813634199, 6132.601380910227, 6142.78500252489, 6158.5381096417495, 6176.907346389808, 5631.577631677641, 5669.688167150764, 5716.5998380113, 5732.942670573324, 5779.624324418899, 6176.81469555914, 6242.563020588515, 6250.843728906813, 6276.215473065867, 6289.433950944437, 6002.069679199731, 6149.385061493815, 6157.538184636171, 6161.661108639068, 6172.259328880563, 4168.062186008185, 4841.564259216688, 5614.382417934024, 5709.429057094258, 6236.0, 5115.488451154929, 6113.32428171423, 6127.448529632355, 6133.233345831771, 6142.692865356804, 5073.771680274396, 6194.194754681863, 6199.0, 6216.751329946842, 6225.564210505312, 4845.854624361275, 4870.318155458239, 4919.877003074952, 4921.188003979303, 4957.380327459067, 3619.9819000905354, 3794.886153415402, 4290.420793192941, 4336.718113322624, 4367.606915377632, 5913.172155898178, 5917.704114794243, 5927.436893495111, 5931.13998470228, 5984.910226346608, 6118.785842495491, 6130.948521380002, 6169.81490555284, 6276.959988003917, 6320.178376810985, 5923.17075609415, 5925.259342582177, 5950.494207992283, 6027.849303767353, 6049.818505444844, 5292.576593872481, 5353.86615334612, 5361.169018802092, 5365.38298095724, 5394.460553944574, 6168.228971378578, 6222.253329600568, 6224.0, 6240.968795155995, 6242.3133455320785, 6179.783707570214, 6187.969060154671, 6201.193844800147, 6216.689165541615, 6222.315545289924, 6299.937000629935, 6319.178506794087, 6322.905156422566, 6356.841078973062, 6368.076628888878, 6041.909371359521, 6062.545309101747, 6084.939150608438, 6092.786752463642, 6104.359042300494, 5906.940930590639, 6144.648177400964, 6162.445379915829, 6162.969185154046, 6183.134361189527, 4793.520647935178, 6052.878942421215, 6092.116643086816, 6114.0, 6117.96941015292, 6093.939060609515, 6096.756129754937, 6112.969435152796, 6144.754209831557, 6147.047207682637, 5674.205611214516, 5820.94179058204, 5827.388124246893, 5863.941360586339, 5879.647221166743, 4719.764011799328, 6101.237345331833, 6107.735039974475, 6117.449429551184, 6121.540884433596, 5828.562857785768, 5915.881682366243, 5950.19672344228, 5964.0, 5968.791092311748], "value": 5596.979441899628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.3371347540398, 481.4800015982738, 508.40516595583176, 508.6312423492968, 530.1094161808161, 31045.844770776144, 39128.80435597825, 40205.79897100518, 40249.59750402499, 42376.788116059455, 33828.830855845685, 41242.17515649685, 41336.72648004359, 41679.79160104203, 41799.0, 9445.905540944588, 9589.328746987714, 9606.75983100421, 9608.039196080406, 9629.951850240739, 9480.81038379232, 9522.523873806316, 9556.474393908333, 9558.139767420931, 9578.664746733866, 8063.798405039892, 8565.0, 8587.0, 9438.867335919665, 9542.618295268181, 9240.168384845363, 9572.904270957271, 9578.377405468656, 9585.993470685547, 9591.472469014201, 9423.57593908269, 9527.951925288213, 9530.904690953072, 9535.570899309549, 9540.141387275109, 37207.62792372068, 37248.696295629525, 39406.80296598528, 39747.8012609938, 39822.00444988869, 3335.6497567755277, 3354.7316214702764, 3361.058903507022, 3448.637893021247, 3934.881953541398, 29314.706852931624, 29474.115776526738, 29910.252243693863, 30087.398252034836, 30356.937507187144, 3078.415101130778, 3159.9368012639848, 3198.440272952224, 3274.429572785376, 3278.09852290622, 353637.0, 353742.0, 355271.0, 355295.0, 357539.0, 57515.71242143846, 57884.0, 57910.0, 57966.710166448895, 57994.13008804871, 59781.103283450786, 59983.0, 60426.395736042075, 60513.69743151256, 60530.0, 15766.211689415484, 16013.359465621477, 16052.876298659216, 16068.116253605931, 16071.116088615005, 12220.205686630341, 12491.188072775421, 12610.621681349574, 12611.49554017829, 12643.925266352278, 14632.561023169323, 15686.215689215494, 15691.686166276611, 15758.212089395485, 15764.842351576566, 5669.518090962232, 6674.833129171712, 6675.0, 6774.593524388552, 6861.348171923659, 862.8015556422058, 1040.427764729411, 1080.778440419712, 1084.3385534823751, 1088.1294964028746, 25805.741942580335, 29187.0, 29543.19564266659, 29966.850165749467, 29966.850165749467, 926.5413620258015, 969.2682025071026, 982.9164521015794, 989.7575094101991, 1016.1667432705111, 15090.773638395432, 15215.923920380548, 15251.313690883937, 15392.769108463383, 15610.609734756496, 442458.0, 573688.0, 608314.0, 609744.0, 611536.0, 55301.72349138228, 55313.44686553164, 55389.723051384484, 55417.44582554123, 55586.888262234526, 1311.4295281552554, 1339.7186590816038, 1357.1992524410646, 1361.6936189357514, 1368.6646771541036, 28801.279968000967, 29102.417951640426, 29301.41397172087, 30005.549916750828, 30030.69969300279, 48030.0, 48496.272555912394, 48512.0, 48559.75720121377, 48674.0, 443456.0, 448682.0, 448835.0, 449335.50664492935, 451690.0, 38135.42796857994, 39386.2122757549, 39558.40662390124, 39566.0, 39581.80209098936, 44674.77662611666, 44773.0, 45020.32469512895, 45029.09941801211, 45182.54817451783, 30977.845110774302, 37568.43647345347, 37639.0, 37723.05692357713, 38472.80763596164, 37554.436683449225, 37791.433128503646, 38186.80906595449, 38372.0, 38621.4206786904, 36156.27687446289, 36468.27063458663, 37243.813780932, 37313.88058358253, 37464.812675936446, 32264.83867580647, 33309.0, 33769.83115084409, 33833.0, 33917.49123763096, 21396.0371783267, 25255.621165682896, 25422.941020656075, 25430.364240894127, 25691.486170276115], "value": 19225.635180392346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.69171204476197, 366.25467174300303, 371.7564994928322, 384.34277385670504, 392.21556886227546, 18666.90666546667, 19104.331348402808, 19530.804691953075, 19807.801921980776, 20002.899985500087, 11175.44122793859, 11476.96707296343, 11483.712907177325, 11505.42472876355, 11519.712007199823, 4884.706917584947, 5353.357597088336, 5394.460553944614, 5401.648892821954, 5408.3504531118, 3821.636944490283, 4027.859024934128, 5283.75831679555, 5705.2012718219485, 6047.788327408542, 6058.9394106059035, 6076.331603523631, 6097.359777223394, 6102.206713127287, 6120.20437343147, 6183.845403864917, 6655.733770649168, 6683.565568238049, 6697.2967838377, 6705.798826035227, 5629.831105066854, 5753.499589746149, 5754.395788442195, 5875.265591801025, 5917.260342457193, 12375.257484550955, 12475.438605262785, 12508.74982500354, 12549.247045177228, 17615.64768704619, 2129.2547608337113, 2277.6355783074628, 2523.356544081266, 2566.833155844864, 2587.042794166152, 8255.587220639005, 9597.184239339664, 9785.315027948047, 9916.603335866557, 10122.696319110439, 1784.4379020608467, 1866.318793640325, 1890.3289332287115, 1909.598984213317, 1918.8752731072575, 111986.0, 114392.0, 117918.41040794826, 121052.78947210503, 127126.0, 11133.665990020312, 11460.426978651034, 11493.655190344303, 11612.709682257842, 11736.119791015708, 14163.0, 14217.431302747775, 14233.861291096895, 14250.144991300347, 14287.57137285883, 8284.171582841667, 8440.577971101544, 8453.619587118594, 8470.195331443503, 8517.233448989497, 7132.609141217413, 8318.958405207935, 8452.112528184574, 8554.01628812682, 8563.357748168912, 4160.750354978711, 4380.189664912002, 4431.601155895921, 4453.198424283595, 4537.1833070047705, 1536.46991787833, 1640.860526855207, 1667.8999260044436, 1859.5908900041968, 1933.8646294759233, 867.3018220332693, 884.3897710579679, 936.1247233836249, 939.5490164720973, 963.5808423335872, 16257.756133658004, 17707.645847082986, 18658.626827463646, 20311.0, 20651.380458586267, 720.9639518024078, 768.7078910014159, 819.0989911097864, 933.3280038372361, 945.8864936207561, 10579.576816927236, 11150.888491115147, 11189.944050279697, 11202.775944481227, 11222.719432014102, 603980.0, 607108.0, 607202.0, 610177.0, 611204.0, 123494.0, 131172.0, 132535.0, 139341.0, 142864.85702714467, 941.4821847983582, 975.9414435133773, 1005.1205195453978, 1006.3961623026272, 1008.2337423558002, 18733.6253274931, 19333.839969601868, 19529.0, 19537.804621953597, 19539.21843126259, 37002.44496332503, 49837.75081124716, 52697.94604107973, 54875.45124548863, 56431.0, 73375.63312183405, 76385.09037274112, 80806.0, 84557.57721211355, 86171.1382886163, 7444.553326800409, 7711.845763084595, 8040.879386809085, 8046.517208967481, 8187.79530511742, 10154.695359139238, 12530.060245481443, 12653.114282000171, 12819.038572106943, 12988.35058247065, 10942.124630029419, 11025.283356581796, 11086.667399978014, 11205.551777928791, 11237.0, 10917.83623245636, 10920.563177472812, 10986.176036797431, 11226.943865280622, 11233.66299011031, 8273.710420135507, 9594.90405095968, 10442.738931526772, 10602.787944240918, 10801.135909127408, 6825.658717064028, 6899.965500172467, 7883.802904927423, 8002.439829211899, 8314.002319721672, 10326.535305911402, 10922.50848711794, 10989.505472253608, 11056.0, 11092.445377731243], "value": 9067.045293538096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.5904746670933, 1500.294861415135, 1660.7544341743692, 1748.4754573627908, 1774.1218097041967, 7629.9237007630045, 7870.094939082007, 8168.0606730226045, 8559.572021398928, 8637.697680581174, 7142.642867856599, 8061.395395345358, 8386.496810191393, 8387.993440787113, 8478.57607119643, 2290.3014580552926, 2319.895604697784, 2320.6983092197993, 2321.6401457774073, 2322.907083716658, 2312.2022902098834, 2348.5302939412186, 2368.7749663781915, 2374.513224788914, 2379.690640216778, 2173.3045425463856, 2174.293354659734, 2184.01719226348, 2195.473086459246, 2198.0987795004053, 1954.6774782160926, 2276.362618466832, 2296.8851557422145, 2323.6398358254414, 2325.6046472099783, 2319.1998760427628, 2353.505763789606, 2357.610994185957, 2362.0905951208906, 2364.456175079741, 7441.479096463249, 8461.323094152453, 8533.573321333908, 8543.40196186261, 8564.186402291773, 5017.172166592544, 5251.291075704808, 5262.210668399733, 5267.28891599633, 5290.0477913975465, 3301.884434044821, 3356.228067544454, 3601.45978103284, 3604.4593311003296, 3606.0624237698125, 1024.9282550221487, 1028.1774580335775, 1057.1278695076592, 1063.9308444951052, 1082.9891701082968, 8679.435836670596, 11037.889621103766, 11109.277896936674, 11118.444077796077, 11122.165837562216, 4492.663050271242, 4572.908541829212, 4659.254519276899, 4682.157211701926, 4705.317728929286, 9546.18857397129, 9584.616615335308, 9626.278029147841, 9631.518424078768, 9689.70930872075, 5228.08508511009, 5231.529162375405, 5240.240165176028, 5242.292290540804, 5247.422783493813, 4263.786810659454, 4283.2932566126865, 4605.539446055434, 4677.602403795648, 4809.398825146856, 3802.3535998880257, 3832.2718683450057, 3859.1702783901596, 3913.295606790748, 3918.1771827916455, 1231.4273862653909, 1236.1470585296117, 1237.9133460657667, 1238.3931873382157, 1242.8446444194476, 786.622421237809, 874.8993865705398, 897.3090720145582, 901.2429559170197, 922.4603606890045, 5870.823875283663, 5913.497352725067, 5942.762289508458, 6002.429769171922, 6206.441420272197, 863.3266052479077, 880.2517859819103, 888.8933328000682, 898.1243287794479, 925.3661242049218, 3275.295811400513, 3794.29805485986, 3875.4961854958674, 3932.783696896641, 3974.4833171688074, 9879.357841740408, 10359.0, 10394.0, 10414.427206503715, 10440.843387349196, 8641.222289993804, 10060.849087263698, 10349.534270957825, 10378.325408848401, 10384.221183411275, 6193.442590166816, 6924.861502770017, 8012.31895288907, 8049.678012879536, 8053.436259461899, 5699.373068962494, 5744.655320680772, 5837.416258374129, 5921.940780592311, 6007.12896629995, 7852.332551733167, 9381.85927211106, 9477.668281610111, 9554.092361225672, 9568.61725530971, 9705.0, 9753.366031207948, 9821.656242031495, 9869.753256168653, 9872.45701486425, 6805.931940680728, 6991.720331186695, 7189.7483588074165, 7293.234210408043, 7458.8508229834015, 7995.360371170176, 8163.551004694561, 8174.100848906496, 8174.427790054639, 8190.754277371689, 7138.892916606152, 7293.927060729325, 7334.266573342623, 7382.741604043833, 7410.703571857065, 7090.468214883801, 7122.715091396286, 7160.713571457083, 7183.066201393785, 7326.9267307326245, 6729.663516824237, 6883.208431030495, 6894.689738961859, 6921.411680007054, 6922.58464492132, 4824.324594556695, 4897.167481528078, 4936.407631084149, 4957.776900039579, 4975.577075948585, 4834.419869615669, 4862.5380588844, 4902.313676085422, 5018.222175562793, 5030.673006254582], "value": 4443.242123591759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2302705398328, 298.29453342844175, 307.6354519893926, 308.487910069285, 309.1421305876193, 4819.421609438951, 5099.311592934952, 5265.973670131653, 5363.463653634634, 5424.4776179076725, 4997.450280469155, 5389.380221274555, 5419.590906364344, 5433.891322173554, 5462.918056229159, 3238.5304130901122, 3399.4220982433044, 3448.3965306071464, 3984.6812255019527, 4166.749995000309, 3431.3823511767873, 3788.867389641363, 3871.522225775506, 3959.247742928834, 4198.244316023115, 4001.4998125234347, 4028.2950483665386, 4062.0, 4073.6130067643526, 4085.754854708712, 3204.3431096625136, 3498.930021399558, 4026.3557830747086, 4039.515258169009, 4041.1917616476676, 3071.032624723205, 3214.791038582508, 3495.3883070462566, 3496.1958749487508, 3499.6675315844955, 4083.7141400102005, 4805.975970120127, 5006.524380183877, 5208.270842082112, 5223.843284701465, 4520.638348932111, 4521.502634710179, 4533.025399539115, 4537.863864084083, 4587.610053145453, 5106.374474123377, 5496.6258435391155, 5525.336959564878, 5545.584081193886, 5617.859553511154, 3678.429843374281, 3766.9623303766884, 3778.244351129785, 3782.432635104729, 3810.7523011004196, 4726.558399688094, 5498.835034948958, 5560.888782224333, 5843.123531470271, 5888.791703111333, 3834.2331533693373, 3877.6897848172644, 3879.612038796154, 3902.843886244518, 3911.7652940823073, 3288.3423315337027, 3590.2407820167928, 3768.717346199046, 3975.5626881043063, 4006.3189257825657, 4545.4545454545005, 4575.084983003413, 4580.923482981497, 4627.722336659744, 4650.4186976627925, 5612.831615051473, 5774.7767109662245, 5779.064013555506, 5828.659408336106, 5838.386969368155, 1094.4746521669642, 1106.6016234155697, 1118.5917140243753, 1209.727811242481, 1285.794272916329, 808.6374459036542, 861.7845538615346, 870.6038752367657, 874.3791907745572, 878.0429332027992, 5164.845054648366, 5190.8961820764125, 5212.149686861186, 5238.7904483820985, 5262.474012474034, 5081.466446023114, 5342.439043900412, 5510.393856675762, 5531.419200983919, 5556.6943818089585, 4812.542808433193, 5045.0, 5066.670666406671, 5088.498892826625, 5139.922901156486, 2760.751532362097, 2882.6684931232758, 2965.851707414664, 2987.5054329635, 3012.4276387486307, 5832.88334233313, 5870.444332251956, 5920.572565248228, 5932.953131169739, 5935.792247271324, 5002.074616196015, 5245.554127899171, 5341.252224688546, 5571.8269874748885, 5718.771249149988, 5081.0092032054135, 5213.7914483421, 5841.970790146022, 5911.379305172895, 5917.319508256605, 5331.413544510023, 5573.265911839158, 5611.775528978795, 5629.155626656035, 5649.717514124195, 4922.064807686528, 5516.475934786189, 5596.916046259391, 5597.328320601554, 5690.544756419394, 5210.843674689765, 5433.130699088285, 5873.296743944208, 5886.264216972879, 5923.851903702442, 3144.1641197738722, 3287.934241315208, 3623.8369273383287, 3707.480952666575, 3720.069982504374, 5185.559227465707, 5329.001624390853, 5885.234919460443, 5885.735141918538, 5950.7917222896995, 4749.24012158053, 5314.62797604164, 5623.943760562342, 5773.711314434346, 5784.161296612052, 5214.765335559985, 5709.7145142741865, 5744.4829965303325, 5748.223989761496, 5792.855178620568, 5379.757910894097, 5607.859803504945, 5631.746571404215, 5642.971785141048, 5649.604527683023, 4721.032188401301, 4775.6657034007285, 5739.282589676291, 5764.971175144097, 5786.392428794916, 4805.8077676892535, 5620.522255608319, 5632.211490391266, 5652.64336559231, 5703.896830391442], "value": 4048.611301405488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2643522032679, 689.3038031588096, 690.9965450172748, 747.6747614787571, 792.4492477727981, 11374.772504549905, 14802.40790368384, 14888.702225955474, 14916.254187290646, 14949.47676831311, 13217.0, 13269.0, 13359.465621375157, 13365.064445488819, 13375.732485350287, 649.4090377756243, 670.1355251725269, 808.5270116981573, 814.6537721468382, 837.392890154636, 820.9917900820975, 833.2375876073386, 833.3874602167402, 833.5707110837923, 837.1628371628371, 876.4128034217058, 882.4749274181852, 884.8716936044302, 886.0386480668483, 886.162576365335, 870.7765589346915, 874.1389731114847, 878.5387671472496, 879.6789171952255, 882.3470631732536, 538.760251687999, 646.8835609590271, 651.4202359899693, 652.5236577298551, 655.813093268421, 13855.515056973058, 14040.1575905446, 14075.436982520687, 14086.084404513675, 14330.57008289753, 12916.741665166737, 12965.805512917314, 12980.091393602452, 13089.34553272342, 13459.259740714257, 11181.44092795357, 11475.598354057567, 11590.884091159065, 11619.954204121585, 11664.94167529157, 3680.6871415929677, 3722.2555488902326, 3740.513733214692, 3759.3233218020746, 3785.091578021255, 92799.0, 96651.03348966561, 96658.0334196656, 97008.0, 98953.5052324741, 10514.789704205874, 10728.0, 10761.354318740901, 10817.83773243402, 10987.505562249718, 20833.89583052075, 20885.477863053242, 20957.371278861658, 21108.944552772606, 21349.78650213509, 7648.541087534654, 7674.232576742281, 7725.92274077252, 7841.960790196013, 7911.762647120596, 4171.249175148441, 4226.640735537452, 4349.021470169187, 4363.650907927358, 4372.322290045048, 3335.4329763940186, 3424.7945123292684, 3431.1936694876686, 3432.8970130896114, 3452.2750222453064, 654.2476152424655, 667.2760055339913, 687.340153452691, 708.777359055625, 710.0166269716377, 514.8532668189548, 566.9291338582677, 595.3064679648248, 612.8192183305936, 621.170737066022, 8355.665773369119, 8379.868717723151, 9190.816183676288, 9336.673216437392, 9465.716028519155, 545.5335687986793, 560.4367610551451, 624.8250489862845, 649.4836604899117, 681.2370145437043, 3986.9202615948097, 4460.174867649495, 4461.866144015685, 4587.770611469413, 4678.532146785362, 70468.2953170472, 90469.0, 98221.0, 117652.82347176419, 129200.3539982294, 83931.0, 86277.0, 88559.55720221487, 97422.5128874351, 99247.0, 55100.448995509534, 56465.87068258694, 77248.61375693085, 88340.0, 93863.53068234616, 9162.816743664956, 9714.75713107178, 9781.902180978384, 9919.504024798876, 9954.303198776017, 42749.35875961801, 53933.73033134966, 55875.72062139826, 58311.26390374037, 58334.708326458094, 52837.735811320694, 61346.69326653338, 79559.60220198861, 79854.0, 81043.59478202571, 12795.31591121424, 12868.292243926673, 13214.0, 13383.598492045254, 13739.519116830863, 13779.931100344435, 14075.788863167265, 14328.211948342941, 14370.928145359207, 14503.854961450672, 12269.815952760537, 13465.663358416117, 13516.25660588677, 13956.511522096678, 14033.298335083, 13436.462541498231, 13794.103383280055, 14086.577402677936, 14100.929495352457, 14142.78785818234, 12290.81563776562, 12595.307258100893, 13384.464621415034, 13722.382492787649, 13771.793423098461, 10259.794804104025, 10398.480075996018, 10891.640005564144, 10905.836412453978, 11349.943250283695, 9052.502112383881, 11203.439828008404, 11507.482163302839, 11546.42267886619, 11556.075513959031], "value": 7279.17640121725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 138.0, 98.0, 164.0, 173.0, 174.0, 121.0, 117.0, 120.0, 118.0], "value": 132.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 117.0, 188.0, 116.0, 134.0, 151.0, 146.0, 136.0, 149.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 196.0, 196.0, 198.0, 198.0, 196.0, 199.0, 203.0, 201.0], "value": 198.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 85.0, 62.0, 60.0, 58.0, 58.0, 80.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 92.0, 74.0, 68.0, 71.0, 97.0, 99.0, 102.0, 91.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 85.0, 90.0, 85.0, 100.0, 86.0, 90.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 171.0, 154.0, 100.0, 132.0, 123.0, 173.0, 153.0, 99.0, 105.0], "value": 132.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 139.0, 136.0, 86.0, 87.0, 88.0, 91.0, 91.0, 88.0, 87.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 71.0, 86.0, 79.0, 75.0, 70.0, 72.0, 74.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 87.0, 75.0, 97.0, 104.0, 84.0, 84.0, 92.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 163.0, 177.0, 147.0, 136.0, 222.0, 194.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 177.0, 229.0, 237.0, 160.0, 234.0, 164.0, 222.0, 233.0, 172.0], "value": 202.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 90.0, 94.0, 78.0, 68.0, 69.0, 70.0, 67.0, 69.0], "value": 74.9, "unit": "score"}]}]} 08:47:10 INFO - Return code: 0 08:47:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:47:11 ERROR - # TBPL SUCCESS # 08:47:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:11 INFO - 2016-11-18 08:47:11.015 screenresolution[1658:10979] starting screenresolution argv=screenresolution get 08:47:11 INFO - 2016-11-18 08:47:11.018 screenresolution[1658:10979] Display 0: 1600x1200x32@60 08:47:11 INFO - 2016-11-18 08:47:11.024 screenresolution[1659:10982] starting screenresolution argv=screenresolution list 08:47:11 INFO - Available Modes on Display 0 08:47:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:11 INFO - Intel Iris: 08:47:11 INFO - Chipset Model: Intel Iris 08:47:11 INFO - Type: GPU 08:47:11 INFO - Bus: Built-In 08:47:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:11 INFO - Vendor: Intel (0x8086) 08:47:11 INFO - Device ID: 0x0a2e 08:47:11 INFO - Revision ID: 0x0009 08:47:11 INFO - Displays: 08:47:11 INFO - Display: 08:47:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:11 INFO - Display Serial Number: 1600x1200 60 08:47:11 INFO - Main Display: Yes 08:47:11 INFO - Mirror: Off 08:47:11 INFO - Online: Yes 08:47:11 INFO - Rotation: Supported 08:47:11 INFO - Return code: 0 08:47:11 INFO - Running post-action listener: _resource_record_post_action 08:47:11 INFO - [mozharness: 2016-11-18 16:47:11.260789Z] Finished run-tests step (success) 08:47:11 INFO - Running post-run listener: _resource_record_post_run 08:47:11 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 39179264; Write bytes: 655579136; Read time: 390; Write time: 2020 08:47:11 INFO - TinderboxPrint: CPU usage
54.3% 08:47:11 INFO - TinderboxPrint: I/O read bytes / time
39,179,264 / 390 08:47:11 INFO - TinderboxPrint: I/O write bytes / time
655,579,136 / 2,020 08:47:11 INFO - TinderboxPrint: CPU idle
2,209.0 (45.7%) 08:47:11 INFO - TinderboxPrint: CPU system
976.9 (20.2%) 08:47:11 INFO - TinderboxPrint: CPU user
1,651.8 (34.1%) 08:47:11 INFO - TinderboxPrint: Swap in / out
391,970,816 / 0 08:47:11 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 354183680; Write bytes: 354969600; Read time: 27630; Write time: 671 08:47:11 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34878464; Write bytes: 299102208; Read time: 353; Write time: 1342 08:47:11 INFO - Running post-run listener: _upload_blobber_files 08:47:11 INFO - Blob upload gear active. 08:47:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:47:11 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 08:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:13 INFO - (blobuploader) - INFO - Done attempting. 08:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:14 INFO - (blobuploader) - INFO - Done attempting. 08:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:47:16 INFO - (blobuploader) - INFO - Done attempting. 08:47:16 INFO - (blobuploader) - INFO - Iteration through files over. 08:47:16 INFO - Return code: 0 08:47:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:47:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:47:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0993e0e783bd25f4258edcdbf9021a0d287edfdbf4082941f9a37738ef7a01158839158b2fcc84a3b16290cabea6f349b1ff8bbc5ef9b54b9308d1f3433e7c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8798dc7fdbbbd8d3713c447cb23bdaf51ed851102771fa06145739d04a10b6b1de8a85c867b1e1abc3260457d2920253f17598a73a9efb609ac15e8f0565d3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797885591b0be8bbdf96bbd3b8bf8c1a2ff0dc85eba54cf0dbe16b0d141507b0ab43db5296dc4268429aa2c9f0bb811834ba69311f26d12112e41e5bb8bec818"} 08:47:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:47:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:47:16 INFO - Contents: 08:47:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0993e0e783bd25f4258edcdbf9021a0d287edfdbf4082941f9a37738ef7a01158839158b2fcc84a3b16290cabea6f349b1ff8bbc5ef9b54b9308d1f3433e7c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8798dc7fdbbbd8d3713c447cb23bdaf51ed851102771fa06145739d04a10b6b1de8a85c867b1e1abc3260457d2920253f17598a73a9efb609ac15e8f0565d3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797885591b0be8bbdf96bbd3b8bf8c1a2ff0dc85eba54cf0dbe16b0d141507b0ab43db5296dc4268429aa2c9f0bb811834ba69311f26d12112e41e5bb8bec818"} 08:47:16 INFO - Running post-run listener: copy_logs_to_upload_dir 08:47:16 INFO - Copying logs to upload dir... 08:47:16 INFO - mkdir: /builds/slave/test/build/upload/logs 08:47:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.385283 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-18 08:47:16.533122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:47:16.536287) ========= 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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/Mozilla-Aurora/sha512/e0993e0e783bd25f4258edcdbf9021a0d287edfdbf4082941f9a37738ef7a01158839158b2fcc84a3b16290cabea6f349b1ff8bbc5ef9b54b9308d1f3433e7c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8798dc7fdbbbd8d3713c447cb23bdaf51ed851102771fa06145739d04a10b6b1de8a85c867b1e1abc3260457d2920253f17598a73a9efb609ac15e8f0565d3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797885591b0be8bbdf96bbd3b8bf8c1a2ff0dc85eba54cf0dbe16b0d141507b0ab43db5296dc4268429aa2c9f0bb811834ba69311f26d12112e41e5bb8bec818"} build_url:https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/GalWbEGDQ2qHUQOolDtSPw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0993e0e783bd25f4258edcdbf9021a0d287edfdbf4082941f9a37738ef7a01158839158b2fcc84a3b16290cabea6f349b1ff8bbc5ef9b54b9308d1f3433e7c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8798dc7fdbbbd8d3713c447cb23bdaf51ed851102771fa06145739d04a10b6b1de8a85c867b1e1abc3260457d2920253f17598a73a9efb609ac15e8f0565d3d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797885591b0be8bbdf96bbd3b8bf8c1a2ff0dc85eba54cf0dbe16b0d141507b0ab43db5296dc4268429aa2c9f0bb811834ba69311f26d12112e41e5bb8bec818"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:47:16.669266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:47:16.669604) ========= 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.Nd4n7aQ3Fo/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.ZIu2gj7B2l/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005267 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:47:16.718922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:47:16.719253) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:47:16.719585) ========= ========= Total master_lag: 0.27 =========