builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0127 starttime: 1484821629.41 results: success (0) buildid: 20170119004006 builduid: d75212b9bf4f4cf6aa3646482ce5737c revision: ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.411249) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.411661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.411975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.439393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.439698) ========= 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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 02:27:09-- 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% 8.12M=0.001s 2017-01-19 02:27:09 (8.12 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118098 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.599425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.599735) ========= 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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.020323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:09.652290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 02:27:09.652621) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b --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 ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 02:27:09,821 truncating revision to first 12 chars 2017-01-19 02:27:09,821 Setting DEBUG logging. 2017-01-19 02:27:09,821 attempt 1/10 2017-01-19 02:27:09,821 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ed6e5d97950a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 02:27:11,442 unpacking tar archive at: mozilla-aurora-ed6e5d97950a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.874029 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-19 02:27:11.554051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:11.554408) ========= script_repo_revision: ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:11.554799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:11.555077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 02:27:11.574802) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-19 02:27:11.575176) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:11 INFO - MultiFileLogger online at 20170119 02:27:11 in /builds/slave/test 02:27:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:27:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:11 INFO - {'append_to_log': False, 02:27:11 INFO - 'base_work_dir': '/builds/slave/test', 02:27:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:27:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:11 INFO - 'branch': 'Mozilla-Aurora', 02:27:11 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:11 INFO - 'config_files': ('talos/mac_config.py',), 02:27:11 INFO - 'default_actions': ('clobber', 02:27:11 INFO - 'read-buildbot-config', 02:27:11 INFO - 'download-and-extract', 02:27:11 INFO - 'populate-webroot', 02:27:11 INFO - 'create-virtualenv', 02:27:11 INFO - 'install', 02:27:11 INFO - 'run-tests'), 02:27:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:11 INFO - 'download_minidump_stackwalk': True, 02:27:11 INFO - 'download_symbols': 'ondemand', 02:27:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:11 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:11 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:11 INFO - 'installer_path': 'installer.exe', 02:27:11 INFO - 'log_level': 'info', 02:27:11 INFO - 'log_name': 'talos', 02:27:11 INFO - 'log_to_console': True, 02:27:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:27:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:27:11 INFO - 'opt_config_files': (), 02:27:11 INFO - 'pip_index': False, 02:27:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:11 INFO - 'cmd': ('bash', 02:27:11 INFO - '-c', 02:27:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:11 INFO - 'enabled': True, 02:27:11 INFO - 'halt_on_failure': False, 02:27:11 INFO - 'name': 'check_screen_resolution'},), 02:27:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:27:11 INFO - 'cmd': ('bash', 02:27:11 INFO - '-c', 02:27:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:27:11 INFO - 'enabled': True, 02:27:11 INFO - 'halt_on_failure': False, 02:27:11 INFO - 'name': 'check_screen_resolution'},), 02:27:11 INFO - 'run_cmd_checks_enabled': True, 02:27:11 INFO - 'sps_profile': False, 02:27:11 INFO - 'sps_profile_interval': 0, 02:27:11 INFO - 'suite': 'dromaeojs', 02:27:11 INFO - 'system_bits': '32', 02:27:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:11 INFO - 'title': 't-yosemite-r7-0127', 02:27:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:11 INFO - 'use_talos_json': True, 02:27:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:11 INFO - 'work_dir': 'build'} 02:27:11 INFO - [mozharness: 2017-01-19 10:27:11.869597Z] Running clobber step. 02:27:11 INFO - Running pre-action listener: _resource_record_pre_action 02:27:11 INFO - Running main action method: clobber 02:27:11 INFO - rmtree: /builds/slave/test/build 02:27:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:13 INFO - Running post-action listener: _resource_record_post_action 02:27:13 INFO - [mozharness: 2017-01-19 10:27:13.368604Z] Finished clobber step (success) 02:27:13 INFO - [mozharness: 2017-01-19 10:27:13.368729Z] Running read-buildbot-config step. 02:27:13 INFO - Running pre-action listener: _resource_record_pre_action 02:27:13 INFO - Running main action method: read_buildbot_config 02:27:13 INFO - Using buildbot properties: 02:27:13 INFO - { 02:27:13 INFO - "project": "", 02:27:13 INFO - "product": "firefox", 02:27:13 INFO - "script_repo_revision": "production", 02:27:13 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:27:13 INFO - "repository": "", 02:27:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:27:13 INFO - "buildid": "20170119004006", 02:27:13 INFO - "stage_platform": "macosx64", 02:27:13 INFO - "basedir": "/builds/slave/test", 02:27:13 INFO - "nightly_build": "True", 02:27:13 INFO - "buildnumber": 20, 02:27:13 INFO - "slavename": "t-yosemite-r7-0127", 02:27:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:27:13 INFO - "platform": "yosemite_r7", 02:27:13 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:27:13 INFO - "branch": "mozilla-aurora", 02:27:13 INFO - "repo_path": "releases/mozilla-aurora", 02:27:13 INFO - "revision": "ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b", 02:27:13 INFO - "pgo_build": "False", 02:27:13 INFO - "builduid": "d75212b9bf4f4cf6aa3646482ce5737c", 02:27:13 INFO - "slavebuilddir": "test" 02:27:13 INFO - } 02:27:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:27:13 INFO - Running post-action listener: _resource_record_post_action 02:27:13 INFO - [mozharness: 2017-01-19 10:27:13.372113Z] Finished read-buildbot-config step (success) 02:27:13 INFO - [mozharness: 2017-01-19 10:27:13.372255Z] Running download-and-extract step. 02:27:13 INFO - Running pre-action listener: _resource_record_pre_action 02:27:13 INFO - Running main action method: download_and_extract 02:27:13 INFO - mkdir: /builds/slave/test/build/tests 02:27:13 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')]} 02:27:13 INFO - trying https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:27:13 INFO - Downloading https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/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 02:27:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/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 02:27:14 INFO - Downloaded 1199 bytes. 02:27:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:27:14 INFO - Using the following test package requirements: 02:27:14 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:27:14 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:27:14 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:27:14 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'jsshell-mac.zip'], 02:27:14 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:27:14 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:27:14 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:27:14 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:27:14 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:27:14 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:27:14 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:27:14 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:27:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:27:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:27:14 INFO - Fetch https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:27:15 INFO - Http code: 200 02:27:15 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 02:27:15 INFO - x-amz-cf-id: Dh9mXRMoRkYLhex6XOIdJt_yZL4aFVAdYzlaS4H2SK6yAwDXtEkSBw== 02:27:15 INFO - x-amz-version-id: wxqlFfp.fVR_t4VQM_yrDygbX1SPivwB 02:27:15 INFO - Expected file size: 16275910 02:27:15 INFO - Obtained file size: 16275910 02:27:22 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 02:27:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:27:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:27:22 INFO - Fetch https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:27:22 INFO - Http code: 200 02:27:22 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 02:27:22 INFO - x-amz-cf-id: KbUEaMJbdAak8xdaFEKimiFNaEtlb2eMP2pbsI4HWFwg6AwTs6Tkgw== 02:27:22 INFO - x-amz-version-id: wxqlFfp.fVR_t4VQM_yrDygbX1SPivwB 02:27:23 INFO - Expected file size: 16275910 02:27:23 INFO - Obtained file size: 16275910 02:27:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:27:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:27:29 INFO - Fetch https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:27:30 INFO - Http code: 200 02:27:30 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 02:27:30 INFO - x-amz-cf-id: 1-KUeO28YFsTaBMvLwat9Z6wzr74eKPUV5KpMMD8FhU7n4IKS4I6FQ== 02:27:30 INFO - x-amz-version-id: PdAtJUutIspdYAHZvNE1GizlcLUX_WnR 02:27:30 INFO - Expected file size: 14409038 02:27:30 INFO - Obtained file size: 14409038 02:27:30 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')]} 02:27:30 INFO - trying https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/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 02:27:33 INFO - Downloaded 110059874 bytes. 02:27:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:27:33 INFO - mkdir: /builds/slave/test/properties 02:27:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:27:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:27:33 INFO - Contents: 02:27:33 INFO - build_url:https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:27:34 INFO - Running post-action listener: _resource_record_post_action 02:27:34 INFO - Running post-action listener: set_extra_try_arguments 02:27:34 INFO - [mozharness: 2017-01-19 10:27:34.318894Z] Finished download-and-extract step (success) 02:27:34 INFO - [mozharness: 2017-01-19 10:27:34.319017Z] Running populate-webroot step. 02:27:34 INFO - Running pre-action listener: _resource_record_pre_action 02:27:34 INFO - Running main action method: populate_webroot 02:27:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:34 INFO - '--tppagecycles', 02:27:34 INFO - '7'], 02:27:34 INFO - 'tests': ['tsvgm']}}, 02:27:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:27:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['damp', 'tps']}, 02:27:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'tests': ['damp', 'tps']}, 02:27:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['dromaeo_dom']}, 02:27:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['basic_compositor_video']}, 02:27:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:27:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['a11yr', 02:27:34 INFO - 'ts_paint', 02:27:34 INFO - 'tpaint', 02:27:34 INFO - 'sessionrestore', 02:27:34 INFO - 'sessionrestore_no_auto_restore', 02:27:34 INFO - 'tabpaint']}, 02:27:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tsvgx', 02:27:34 INFO - 'tsvgr_opacity', 02:27:34 INFO - 'tart', 02:27:34 INFO - 'tscrollx', 02:27:34 INFO - 'cart']}, 02:27:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:34 INFO - 'tsvgr_opacity', 02:27:34 INFO - 'tart', 02:27:34 INFO - 'tscrollx', 02:27:34 INFO - 'cart']}, 02:27:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s'], 02:27:34 INFO - 'tests': ['tp5o']}, 02:27:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'tests': ['tp5o']}, 02:27:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'talos_options': ['--disable-e10s', 02:27:34 INFO - '--xperf_path', 02:27:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:34 INFO - 'tests': ['tp5n']}, 02:27:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:34 INFO - 'talos_options': ['--xperf_path', 02:27:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:34 INFO - 'tests': ['tp5n']}}, 02:27:34 INFO - 'talos.zip': {'path': '', 02:27:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:34 INFO - Running post-action listener: _resource_record_post_action 02:27:34 INFO - [mozharness: 2017-01-19 10:27:34.338084Z] Finished populate-webroot step (success) 02:27:34 INFO - [mozharness: 2017-01-19 10:27:34.338215Z] Running create-virtualenv step. 02:27:34 INFO - Running pre-action listener: _resource_record_pre_action 02:27:34 INFO - Running main action method: create_virtualenv 02:27:34 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:34 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 02:27:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:34 INFO - Using real prefix '/tools/python27' 02:27:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:38 INFO - Installing pip.................done. 02:27:38 INFO - Return code: 0 02:27:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:27:38 INFO - Reading from file tmpfile_stdout 02:27:38 INFO - Output received: 02:27:38 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) 02:27:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:38 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:38 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 02:27:38 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 02:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:38 INFO - 'HOME': '/Users/cltbld', 02:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:38 INFO - 'LOGNAME': 'cltbld', 02:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:38 INFO - 'MOZ_NO_REMOTE': '1', 02:27:38 INFO - 'NO_EM_RESTART': '1', 02:27:38 INFO - 'PAGER': '/bin/cat', 02:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:38 INFO - 'PWD': '/builds/slave/test', 02:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:38 INFO - 'SHELL': '/bin/bash', 02:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:38 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:38 INFO - 'USER': 'cltbld', 02:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:38 INFO - 'XPC_FLAGS': '0x0', 02:27:38 INFO - 'XPC_SERVICE_NAME': '0', 02:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:38 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 02:27:38 INFO - Cleaning up... 02:27:38 INFO - Return code: 0 02:27:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:38 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:38 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 02:27:38 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 02:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:38 INFO - 'HOME': '/Users/cltbld', 02:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:38 INFO - 'LOGNAME': 'cltbld', 02:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:38 INFO - 'MOZ_NO_REMOTE': '1', 02:27:38 INFO - 'NO_EM_RESTART': '1', 02:27:38 INFO - 'PAGER': '/bin/cat', 02:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:38 INFO - 'PWD': '/builds/slave/test', 02:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:38 INFO - 'SHELL': '/bin/bash', 02:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:38 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:38 INFO - 'USER': 'cltbld', 02:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:38 INFO - 'XPC_FLAGS': '0x0', 02:27:38 INFO - 'XPC_SERVICE_NAME': '0', 02:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:38 INFO - Downloading/unpacking psutil>=3.1.1 02:27:38 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 02:27:38 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 02:27:38 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 02:27:38 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 02:27:38 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 02:27:38 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 02:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:42 INFO - Installing collected packages: psutil 02:27:42 INFO - Running setup.py install for psutil 02:27:42 INFO - building 'psutil._psutil_osx' extension 02:27:42 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 02:27:42 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 02:27:42 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 02:27:42 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 02:27:42 INFO - building 'psutil._psutil_posix' extension 02:27:42 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 02:27:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:27:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:27:42 INFO - ^ 02:27:42 INFO - 1 warning generated. 02:27:42 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 02:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:43 INFO - Successfully installed psutil 02:27:43 INFO - Cleaning up... 02:27:43 INFO - Return code: 0 02:27:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:43 INFO - 'HOME': '/Users/cltbld', 02:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:43 INFO - 'LOGNAME': 'cltbld', 02:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:43 INFO - 'MOZ_NO_REMOTE': '1', 02:27:43 INFO - 'NO_EM_RESTART': '1', 02:27:43 INFO - 'PAGER': '/bin/cat', 02:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:43 INFO - 'PWD': '/builds/slave/test', 02:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:43 INFO - 'SHELL': '/bin/bash', 02:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:43 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:43 INFO - 'USER': 'cltbld', 02:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:43 INFO - 'XPC_FLAGS': '0x0', 02:27:43 INFO - 'XPC_SERVICE_NAME': '0', 02:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:46 INFO - Installing collected packages: mozsystemmonitor 02:27:46 INFO - Running setup.py install for mozsystemmonitor 02:27:46 INFO - Successfully installed mozsystemmonitor 02:27:46 INFO - Cleaning up... 02:27:46 INFO - Return code: 0 02:27:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:27:46 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')]} 02:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:46 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')]} 02:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:46 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:46 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 02:27:46 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 02:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:46 INFO - 'HOME': '/Users/cltbld', 02:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:46 INFO - 'LOGNAME': 'cltbld', 02:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:46 INFO - 'MOZ_NO_REMOTE': '1', 02:27:46 INFO - 'NO_EM_RESTART': '1', 02:27:46 INFO - 'PAGER': '/bin/cat', 02:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:46 INFO - 'PWD': '/builds/slave/test', 02:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:46 INFO - 'SHELL': '/bin/bash', 02:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:46 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:46 INFO - 'USER': 'cltbld', 02:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:46 INFO - 'XPC_FLAGS': '0x0', 02:27:46 INFO - 'XPC_SERVICE_NAME': '0', 02:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:46 INFO - Downloading/unpacking jsonschema==2.5.1 02:27:46 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 02:27:46 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 02:27:46 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 02:27:46 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 02:27:46 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 02:27:46 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 02:27:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:27:49 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 02:27:49 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 02:27:49 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 02:27:49 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 02:27:49 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 02:27:49 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 02:27:49 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:49 INFO - warning: no files found matching '*.txt' 02:27:49 INFO - no previously-included directories found matching 'build' 02:27:49 INFO - no previously-included directories found matching 'dist' 02:27:49 INFO - no previously-included directories found matching '.git*' 02:27:49 INFO - Installing collected packages: jsonschema, functools32 02:27:49 INFO - Running setup.py install for functools32 02:27:49 INFO - warning: no files found matching '*.txt' 02:27:49 INFO - no previously-included directories found matching 'build' 02:27:49 INFO - no previously-included directories found matching 'dist' 02:27:49 INFO - no previously-included directories found matching '.git*' 02:27:49 INFO - Successfully installed jsonschema functools32 02:27:49 INFO - Cleaning up... 02:27:50 INFO - Return code: 0 02:27:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:50 INFO - 'HOME': '/Users/cltbld', 02:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:50 INFO - 'LOGNAME': 'cltbld', 02:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:50 INFO - 'MOZ_NO_REMOTE': '1', 02:27:50 INFO - 'NO_EM_RESTART': '1', 02:27:50 INFO - 'PAGER': '/bin/cat', 02:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:50 INFO - 'PWD': '/builds/slave/test', 02:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:50 INFO - 'SHELL': '/bin/bash', 02:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:50 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:50 INFO - 'USER': 'cltbld', 02:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:50 INFO - 'XPC_FLAGS': '0x0', 02:27:50 INFO - 'XPC_SERVICE_NAME': '0', 02:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:27:50 INFO - Cleaning up... 02:27:50 INFO - Return code: 0 02:27:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:50 INFO - 'HOME': '/Users/cltbld', 02:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:50 INFO - 'LOGNAME': 'cltbld', 02:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:50 INFO - 'MOZ_NO_REMOTE': '1', 02:27:50 INFO - 'NO_EM_RESTART': '1', 02:27:50 INFO - 'PAGER': '/bin/cat', 02:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:50 INFO - 'PWD': '/builds/slave/test', 02:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:50 INFO - 'SHELL': '/bin/bash', 02:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:50 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:50 INFO - 'USER': 'cltbld', 02:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:50 INFO - 'XPC_FLAGS': '0x0', 02:27:50 INFO - 'XPC_SERVICE_NAME': '0', 02:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:27:50 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 02:27:50 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 02:27:50 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 02:27:50 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 02:27:50 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 02:27:50 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 02:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:54 INFO - Downloading docopt-0.6.1.tar.gz 02:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:54 INFO - Running setup.py install for blobuploader 02:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:54 INFO - Running setup.py install for requests 02:27:55 INFO - Running setup.py install for docopt 02:27:55 INFO - Successfully installed blobuploader requests docopt 02:27:55 INFO - Cleaning up... 02:27:55 INFO - Return code: 0 02:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:55 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:55 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 02:27:55 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 02:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:55 INFO - 'HOME': '/Users/cltbld', 02:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:55 INFO - 'LOGNAME': 'cltbld', 02:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:55 INFO - 'MOZ_NO_REMOTE': '1', 02:27:55 INFO - 'NO_EM_RESTART': '1', 02:27:55 INFO - 'PAGER': '/bin/cat', 02:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:55 INFO - 'PWD': '/builds/slave/test', 02:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:55 INFO - 'SHELL': '/bin/bash', 02:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:55 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:55 INFO - 'USER': 'cltbld', 02:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:55 INFO - 'XPC_FLAGS': '0x0', 02:27:55 INFO - 'XPC_SERVICE_NAME': '0', 02:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-xe_VMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-dCk4MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-AdoucT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-bX6owP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-7Lfh5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-fqkttB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-bRE5wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-KX59Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-FOCw9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-2zspAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-SAUHBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-UgraNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-fGZ8oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-xZY_i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:57 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-GzCHPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:57 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-7bnKxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:57 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-XCdcWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:57 INFO - Running setup.py install for manifestparser 02:27:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:57 INFO - Running setup.py install for mozcrash 02:27:57 INFO - Running setup.py install for mozdebug 02:27:57 INFO - Running setup.py install for mozdevice 02:27:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:57 INFO - Running setup.py install for mozfile 02:27:58 INFO - Running setup.py install for mozhttpd 02:27:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for mozinfo 02:27:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for mozInstall 02:27:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for mozleak 02:27:58 INFO - Running setup.py install for mozlog 02:27:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:58 INFO - Running setup.py install for moznetwork 02:27:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for mozprocess 02:27:59 INFO - Running setup.py install for mozprofile 02:27:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for mozrunner 02:27:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Running setup.py install for mozscreenshot 02:27:59 INFO - Running setup.py install for moztest 02:27:59 INFO - Running setup.py install for mozversion 02:27:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:59 INFO - Cleaning up... 02:27:59 INFO - Return code: 0 02:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:59 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:27:59 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 02:27:59 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 02:27:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:27:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:59 INFO - 'HOME': '/Users/cltbld', 02:27:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:59 INFO - 'LOGNAME': 'cltbld', 02:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:59 INFO - 'MOZ_NO_REMOTE': '1', 02:27:59 INFO - 'NO_EM_RESTART': '1', 02:27:59 INFO - 'PAGER': '/bin/cat', 02:27:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:59 INFO - 'PWD': '/builds/slave/test', 02:27:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:59 INFO - 'SHELL': '/bin/bash', 02:27:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:27:59 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:27:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:59 INFO - 'USER': 'cltbld', 02:27:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:59 INFO - 'XPC_FLAGS': '0x0', 02:27:59 INFO - 'XPC_SERVICE_NAME': '0', 02:27:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-XZskUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-3YDcEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-7ryRPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-xz9rOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-MfTW_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-qKy2eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-xlErTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:00 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)) 02:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:00 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-r3YE_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Oj_252-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ItWiy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-WYQ60q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-y5rRZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-RivH88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-CrwJG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-V3_r5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:01 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-FtUZKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:01 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-XAio_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:02 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)) 02:28:02 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)) 02:28:02 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)) 02:28:02 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)) 02:28:02 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)) 02:28:02 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)) 02:28:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:02 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 02:28:02 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 02:28:02 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 02:28:02 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 02:28:02 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 02:28:02 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 02:28:04 INFO - Downloading blessings-1.6.tar.gz 02:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:04 INFO - Installing collected packages: blessings 02:28:04 INFO - Running setup.py install for blessings 02:28:04 INFO - Successfully installed blessings 02:28:04 INFO - Cleaning up... 02:28:05 INFO - Return code: 0 02:28:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:05 INFO - Reading from file tmpfile_stdout 02:28:05 INFO - Current package versions: 02:28:05 INFO - blessings == 1.6 02:28:05 INFO - blobuploader == 1.2.4 02:28:05 INFO - docopt == 0.6.1 02:28:05 INFO - functools32 == 3.2.3-2 02:28:05 INFO - jsonschema == 2.5.1 02:28:05 INFO - manifestparser == 1.1 02:28:05 INFO - mozInstall == 1.12 02:28:05 INFO - mozcrash == 1.0 02:28:05 INFO - mozdebug == 0.1 02:28:05 INFO - mozdevice == 0.48 02:28:05 INFO - mozfile == 1.2 02:28:05 INFO - mozhttpd == 0.7 02:28:05 INFO - mozinfo == 0.9 02:28:05 INFO - mozleak == 0.1 02:28:05 INFO - mozlog == 3.4 02:28:05 INFO - moznetwork == 0.27 02:28:05 INFO - mozprocess == 0.23 02:28:05 INFO - mozprofile == 0.28 02:28:05 INFO - mozrunner == 6.13 02:28:05 INFO - mozscreenshot == 0.1 02:28:05 INFO - mozsystemmonitor == 0.3 02:28:05 INFO - moztest == 0.8 02:28:05 INFO - mozversion == 1.4 02:28:05 INFO - psutil == 3.1.1 02:28:05 INFO - requests == 1.2.3 02:28:05 INFO - wsgiref == 0.1.2 02:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:05 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')]} 02:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:05 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')]} 02:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:05 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:28:05 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 02:28:05 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 02:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:05 INFO - 'HOME': '/Users/cltbld', 02:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:05 INFO - 'LOGNAME': 'cltbld', 02:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:05 INFO - 'MOZ_NO_REMOTE': '1', 02:28:05 INFO - 'NO_EM_RESTART': '1', 02:28:05 INFO - 'PAGER': '/bin/cat', 02:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:05 INFO - 'PWD': '/builds/slave/test', 02:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:05 INFO - 'SHELL': '/bin/bash', 02:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:28:05 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:05 INFO - 'USER': 'cltbld', 02:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:05 INFO - 'XPC_FLAGS': '0x0', 02:28:05 INFO - 'XPC_SERVICE_NAME': '0', 02:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 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)) 02:28:06 INFO - Cleaning up... 02:28:06 INFO - Return code: 0 02:28:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:06 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')]} 02:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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')]} 02:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:06 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 0x10d4ec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d462570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc74b49a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, '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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 02:28:06 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 02:28:06 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 02:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:06 INFO - 'HOME': '/Users/cltbld', 02:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:06 INFO - 'LOGNAME': 'cltbld', 02:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:06 INFO - 'MOZ_NO_REMOTE': '1', 02:28:06 INFO - 'NO_EM_RESTART': '1', 02:28:06 INFO - 'PAGER': '/bin/cat', 02:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:06 INFO - 'PWD': '/builds/slave/test', 02:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:06 INFO - 'SHELL': '/bin/bash', 02:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:28:06 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:06 INFO - 'USER': 'cltbld', 02:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:06 INFO - 'XPC_FLAGS': '0x0', 02:28:06 INFO - 'XPC_SERVICE_NAME': '0', 02:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:06 INFO - Cleaning up... 02:28:06 INFO - Return code: 0 02:28:06 INFO - Running post-action listener: _resource_record_post_action 02:28:06 INFO - Running post-action listener: _start_resource_monitoring 02:28:06 INFO - Starting resource monitoring. 02:28:06 INFO - [mozharness: 2017-01-19 10:28:06.951972Z] Finished create-virtualenv step (success) 02:28:06 INFO - [mozharness: 2017-01-19 10:28:06.953042Z] Running install step. 02:28:06 INFO - Running pre-action listener: _resource_record_pre_action 02:28:06 INFO - Running main action method: install 02:28:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:07 INFO - Reading from file tmpfile_stdout 02:28:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:07 INFO - Reading from file tmpfile_stdout 02:28:07 INFO - Output received: 02:28:07 INFO - Usage: mozinstall [options] installer 02:28:07 INFO - Options: 02:28:07 INFO - -h, --help show this help message and exit 02:28:07 INFO - -d DEST, --destination=DEST 02:28:07 INFO - Directory to install application into. [default: 02:28:07 INFO - "/builds/slave/test"] 02:28:07 INFO - --app=APP Application being installed. [default: firefox] 02:28:07 INFO - mkdir: /builds/slave/test/build/application 02:28:07 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'] 02:28:07 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 02:28:38 INFO - Reading from file tmpfile_stdout 02:28:38 INFO - Output received: 02:28:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:28:38 INFO - Running post-action listener: _resource_record_post_action 02:28:38 INFO - [mozharness: 2017-01-19 10:28:38.732183Z] Finished install step (success) 02:28:38 INFO - [mozharness: 2017-01-19 10:28:38.732337Z] Running run-tests step. 02:28:38 INFO - Running pre-action listener: _resource_record_pre_action 02:28:38 INFO - Running main action method: run_tests 02:28:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:38 INFO - 2017-01-19 02:28:38.747 screenresolution[1898:12810] starting screenresolution argv=screenresolution get 02:28:38 INFO - 2017-01-19 02:28:38.749 screenresolution[1898:12810] Display 0: 1600x1200x32@60 02:28:38 INFO - 2017-01-19 02:28:38.756 screenresolution[1899:12812] starting screenresolution argv=screenresolution list 02:28:38 INFO - Available Modes on Display 0 02:28:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:38 INFO - Intel Iris: 02:28:38 INFO - Chipset Model: Intel Iris 02:28:38 INFO - Type: GPU 02:28:38 INFO - Bus: Built-In 02:28:38 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:38 INFO - Vendor: Intel (0x8086) 02:28:38 INFO - Device ID: 0x0a2e 02:28:38 INFO - Revision ID: 0x0009 02:28:38 INFO - Displays: 02:28:38 INFO - Display: 02:28:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:38 INFO - Display Serial Number: 1600x1200 60 02:28:38 INFO - Main Display: Yes 02:28:38 INFO - Mirror: Off 02:28:38 INFO - Online: Yes 02:28:38 INFO - Rotation: Supported 02:28:38 INFO - Return code: 0 02:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:38 INFO - Python 2.7.3 02:28:38 INFO - Return code: 0 02:28:38 INFO - grabbing minidump binary from tooltool 02:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:38 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 0x10d300d30>, '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 0x10d166db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d2f8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:38 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 02:28:38 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 02:28:38 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 02:28:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:39 INFO - Return code: 0 02:28:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:28:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:28:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0127 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8xnQXpuB1B/Render', 02:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:28:39 INFO - 'HOME': '/Users/cltbld', 02:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:28:39 INFO - 'LOGNAME': 'cltbld', 02:28:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:39 INFO - 'MOZ_NO_REMOTE': '1', 02:28:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:39 INFO - 'NO_EM_RESTART': '1', 02:28:39 INFO - 'PAGER': '/bin/cat', 02:28:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:39 INFO - 'PWD': '/builds/slave/test', 02:28:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:28:39 INFO - 'SHELL': '/bin/bash', 02:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKMvMg6Mk2/Listeners', 02:28:39 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:28:39 INFO - 'USER': 'cltbld', 02:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:39 INFO - 'XPC_FLAGS': '0x0', 02:28:39 INFO - 'XPC_SERVICE_NAME': '0', 02:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:28:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:28:39 INFO - mozversion application_buildid: 20170119004006 02:28:39 INFO - mozversion application_changeset: ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b 02:28:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:28:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:39 INFO - mozversion application_name: Firefox 02:28:39 INFO - mozversion application_remotingname: firefox-dev 02:28:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:39 INFO - mozversion application_vendor: Mozilla 02:28:39 INFO - mozversion application_version: 52.0a2 02:28:39 INFO - mozversion platform_buildid: 20170119004006 02:28:39 INFO - mozversion platform_changeset: ed6e5d97950a01e80679a17e7abd4a3ed28e8f6b 02:28:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:39 INFO - mozversion platform_version: 52.0a2 02:28:39 INFO - using testdate: 1484821719 02:28:39 INFO - actual date: 1484821719 02:28:39 INFO - starting webserver on 'localhost:51490' 02:28:39 INFO - SUITE-START | Running 2 tests 02:28:39 INFO - TEST-START | dromaeo_css 02:28:39 INFO - operating with platform_type : mac_ 02:28:39 INFO - Initialising browser for dromaeo_css test... 02:28:39 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpBGY2f5/profile http://localhost:51490/getInfo.html) 02:28:42 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 02:28:42 INFO - PROCESS | 1909 | colorDepth:24 02:28:42 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 02:28:42 INFO - PROCESS | 1909 | __metrics 02:28:42 INFO - PROCESS | 1909 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:28:42 INFO - PROCESS | 1909 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:43 INFO - TEST-INFO | 1909: exit 0 02:28:43 INFO - Browser initialized. 02:28:43 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:43 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpBGY2f5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:55 INFO - PROCESS | 1913 | RSS: Main: 222150656 02:28:55 INFO - PROCESS | 1913 | 02:31:59 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51490/tests/dromaeo/cssquery-ext.html) 02:32:01 INFO - PROCESS | 1913 | RSS: Main: 348143616 02:32:01 INFO - PROCESS | 1913 | 02:35:04 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-ext.html (next: http://localhost:51490/tests/dromaeo/cssquery-jquery.html) 02:35:04 INFO - PROCESS | 1913 | RSS: Main: 343887872 02:35:04 INFO - PROCESS | 1913 | 02:38:06 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51490/tests/dromaeo/cssquery-mootools.html) 02:38:07 INFO - PROCESS | 1913 | RSS: Main: 318656512 02:38:07 INFO - PROCESS | 1913 | 02:41:09 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51490/tests/dromaeo/cssquery-prototype.html) 02:41:10 INFO - PROCESS | 1913 | RSS: Main: 317628416 02:41:10 INFO - PROCESS | 1913 | 02:44:13 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51490/tests/dromaeo/cssquery-yui.html) 02:44:14 INFO - PROCESS | 1913 | RSS: Main: 311062528 02:44:14 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-yui.html (next: http://localhost:51490/tests/dromaeo/cssquery-dojo.html) 02:47:17 INFO - PROCESS | 1913 | RSS: Main: 356352000 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | __start_tp_report 02:47:17 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 02:47:17 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 02:47:17 INFO - PROCESS | 1913 | |i|pagename|runs| 02:47:17 INFO - PROCESS | 1913 | |0;dojo.html;3279.524468952002;3297.0768184908225;3299.4555898276785;3312.3540909522653;3355.983220083899;5625.296837895263;5658.886822263552;5682.346530149034;5707.315122185333;5716.428357164286;5645.435456454353;5745.971270143644;5761.078227483604;5762.56780741445;5762.855928601787;4342.826286948526;5211.661242019257;5236.266922630834;5245.370555533342;5299.6820190788485;5133.383993920735;5150.33045704058;5156.742162891859;5359.812406565771;5369.570434365261;5196.454372290912;5220.295260139889;5242.161254199329;5260.684358938457;5262.947370526284;5274.024305503494;5296.92054619181;5337.492938170868;5343.385510666245;5347.0909945309395;5107.157319042353;5165.741712914377;5262.236975638511;5267.736613169326;5290.100682883919;4724;5651;5665.291838520185;5689.118186681071;5703.458171473703;5117.897642047138;6125.142480052797;6222.906656400158;6269.435750782406;6286.214223222098;6322.272938612026;6333.87332253357;6360.840978975516;6361.491080713532;6366.299707032223;5621.381648018673;5674.943250567524;5691.573132015033;5727.341355744059;5779.959607270732;6286.9056964145575;6299.6850157491945;6300.21247344082;6304.65324407162;6310.211223597051;6116.694165291718;6124.989376752786;6145.016797312409;6150.138980542728;6152.107944348134;6053.031514957585;6073.423024812636;6123.923256659767;6164.260288765287;6296.433321001132;5380.735527151116;5841.620294680833;6123.203983482119;6133.049377346519;6139.140520327158;6114.062842019308;6121.357257487989;6131.774283661951;6143.43342447673;6193.721282542297;4934.777934992934;4945;4952.182889823211;4957.677750946177;4975.601951843843;4394.846180383671;4409.581089796464;4409.977950110229;4415.249407600716;4419.889502762392;5586.776528938797;5642.605017648807;5653.547716182778;5670.376258611549;5727.713614319267;6260.655663938436;6299.244090709052;6312.968435157886;6316.873662526724;6351.777687780906;5687.317521897398;5696.601237913306;5706.771729130788;5747.281589801275;5753.223314852441;5284.101702710548;5404.621676482609;5404.891902162013;5415.783368665209;5429.782808687687;6254.437100660781;6258.249010118815;6275.466585340206;6279.780207692709;6291.685415729104;6298.496120310272;6306.9684651576445;6311.90532142009;6314.494840412848;6323.494120470259;6189.35011823752;6261.843453913506;6276.874462510816;6321.209848768904;6344;6027;6071.9981203101;6081.878362432638;6120.296165940974;6209.689515524115;6242.65665388408;6279.654618995816;6287.622742635456;6296.590721603265;6300.779472718433;6089.330173680803;6094.451499365078;6102.481289090477;6117.235345581802;6118.051701986199;5882.499987500939;5924.763009479572;6016.368281330398;6025.548083893813;6067.12026756109;5798.420157984167;5843.386444423274;5924.081767326072;5977.282726072899;5999.1601175836295;6127.264728232641;6144.508439324933;6145.477634400947;6162.537809664203;6171.444569988723;5717.542596592346;5815.505682017076;5926.644401335933;5930.28836539618;5977.252843394575 02:47:17 INFO - PROCESS | 1913 | |1;ext.html;416.8311833707349;486.89775147219086;505.7547089661513;508.2883962452568;513.9643618109508;23961.880190599044;39051;40515.59484405155;40614.796926015326;42475.36286955698;41704;42052;42171.57828421715;42184;42254.36618450726;8151.388645851555;9130.269578433727;9307.72076837696;9318.347715659907;9354.532273386338;8178.918210817875;10918.781624367508;11205.60780372683;11209.383483908381;11213.831792523119;10763.83854242187;10860.782784344308;10887.455627218607;10915.563377464892;10930.56277748889;10936.179786516004;11011.889881101166;11024.559017639285;11046.613368532144;11078.501467433985;10904.454777261184;10973.670789876316;10978.615748448767;10995.010449059542;11018.779624407467;37798.055048624;38203.04492387685;38234.617653823385;38254.61745382538;38346;3186.9521957170427;3194.0896844399235;3223.9677603223904;3347.163209197701;3508.9648553676725;28040.298992525146;28186.43627127446;28429.00498482564;28517.714822851714;28964.8551757242;2769.5014897318474;3135.702108299708;3187.505936579834;3200.0398386534443;3250.7886987345746;476346;479608;479649.9999999965;480168;480358;32659.34681306408;33413.66586334154;54527;54903.450965490636;55040.44959550353;35353.46969795455;35448.64551354505;35477.29045419077;35510.82244588812;35597.46603800945;12190.75618487643;14250.501232456814;14392.496262630757;14438;14440.205788681513;11072.723181920517;11320.037796787365;11339.886601134049;12012.699682508008;12064.974477169364;7396.519226250277;7448.925510744932;7452.739154129579;7458.477906546598;7650.31147196755;3184.617845858512;3208.278137419062;3223.3553289342226;3232.69289417505;3242.4001559711055;859.6987567739909;886.9068747781519;940.9200217981548;1011.544804837826;1023.8003589300164;28784.568231476544;29518.557221641262;29671.85164074209;30339.69660303413;30399.544006839915;902.7291812456236;935.3592788939599;1006.3710181136789;1020.3928662445833;1074.237291523012;15273.770893436607;15338.0797152169;15402.537923862303;15568.143752093518;15644.217789110498;670180.1400922996;678298;679011.4197716018;679188.6040569765;679692;57715;58344.7082764592;58388.4161158383;58443.70778146167;58522.12216816751;1322.1604281281454;1357.2670757790681;1375.2504884837588;1377.8415482219473;1381.5717127690448;28050.57924131099;28243.576346355232;28888.844446221916;29317.706822932352;29563.600185978026;47164.292535611305;47477.76261118672;47560.04879902452;47577.76211118922;47581;582510;583704;584006;585585;587040;24611.630825537988;25571.61642575326;25613;25646.358841029123;25651.35871603225;37340;43582.78208608937;45033.32450013318;46264.53735462737;47216.527834721215;36049.27901442009;36245.09387265339;37361;38313.4252986211;39607.20785584215;37957;38477.422838658;39170.608293916695;39517.40723889202;39695.80152099221;29534;36013.0996725084;36434.27131457409;36472.81763591165;37285;32199.35601288008;32239.032829015166;33593.49609755807;33720.49419258664;33775.66224337823;24728.505429891662;24906.875465622557;25012.2427767618;25172.24483265505;25333.746662533875 02:47:17 INFO - PROCESS | 1913 | |2;jquery.html;329.27887925443264;359.6206002667186;367.32779014403644;372.48968912589754;390.3461701649738;18737;19419.32032378867;19485.22059117637;20541;20732.27437039704;15529.22353882307;18191.272349106053;20215.393538193843;20748;20816.375508734724;5542.91685624716;5788.5658575606785;5789.536837053047;5792.4497172768515;5807.070868661015;5414;5700.201971723962;5761.308642962829;5764.625299355549;5768.567357448187;5557.638753481031;5715.571332150084;5722.885542289152;5728.770849166029;5740.052891272935;5542.5565954723525;5666.914996275059;5694.259746233005;5703.344115426696;5709.486146246858;4853.4418541867435;4948.572393482042;4995.5753760930365;5012.674176178573;5020.748962551895;20472.897635511727;24848.751512484825;25007.874960625264;25037;25312.620310695354;2251.7072780538588;2253.1100215414817;2316.9189078382174;2406.0736616402637;2410.5419970205603;14864.959452838306;15242.771358429633;15244.771328430083;15343.693126137414;16030.038197708174;1783.6343549572307;1828.469743774317;1840.1627259596985;1871.3824437935448;1879.1074239736154;114748.42625786818;115736.42131789288;116354.41822790832;118346;119104;10345.275830691779;10575.41835199056;10787.730306742395;10911.127109831194;11036.227464077438;13492.797608035888;13503.392347344394;13546.796798048037;13550.322483875767;13627.114237574526;8165.63254653542;8362.623681934327;8365.330773538102;8465.365097617703;8481.109483504266;8382.329413646894;8394.496330220207;8415.705450309331;8519.148085191431;8551.957240213884;5626.943730562723;6532;6595.142631457879;6607.2651141561455;6750.088738020305;1712.6917154911987;1788.025526088285;1790.3017823049022;1793.2199493220492;1794.641071785622;928.767808047988;971.6259240192577;993.8608594796734;1001.9198464122853;1079.5681727308981;20079.29722459736;20304.39086827368;21396.679049814265;21949.90250487469;21994.780052199592;945.6879229854131;945.8486642137225;945.9385139966017;950.8811398575178;960.500539719342;9685;10850.67447976562;10948.945255273831;11299.49152288149;11587.710307242387;515830;583519;586585;591423;600235;57451.71274143602;57549;65660;105158.47420762847;105605;876.4434584039182;956.8229877472829;984.7636567223958;986.6448078691665;988.8220120378401;18947.33684321042;19847.900760496683;19850.404487865388;19923.302684405975;20077.698834517785;46270.53729462797;49026;49554.75222623864;51046.93718376909;52905.7354713224;65877.67061164664;69738;70182.94725579223;70504.64747676229;73249.6337518309;6887.621180835102;7106.822329441805;7235.927640723526;7255.383292419992;7438.702451901863;9321.580528876353;12222.449989750305;12313.199642023239;12404.503819847105;12577.748445030866;10556.84164737545;10795.082417994558;10886.074683651977;11195.776084478428;11198.16013798952;8745.344099192458;10436.478176091317;10594.788104237718;10661.307015043998;10993.010629043425;10897.237193396386;11036.337819730841;11269.71825704364;11333.26333788301;11404.289356596577;7238.6018768968215;7389.298016688406;7395.704171833282;7418.332350088518;7594.126675432175;8446.450980686235;10865.891341086488;10882.836757448804;11250.549978001116;11267.323960562393 02:47:17 INFO - PROCESS | 1913 | |3;mootools.html;1458.993294626708;1498.4006397441021;1637.557859377968;1811.6376724655072;1819.4359748477973;7984.520928744279;8386.832263354729;8393.748187554367;8394.454360466565;8402.91597084029;7419.591922444277;7660.693572257117;7671.232876712326;8033.678652853893;8184.959075204631;2265.5921934051903;2305.6772051912744;2312.236961802601;2313;2313.190383365817;2297.540491901618;2310.1221535816367;2321.8258630602772;2344.5662552427857;2347.272345572878;2277.1574517428576;2284.805791507724;2303.562323158603;2304.8962796674105;2316.3514216019457;2272.5000499889998;2286.325533967484;2290.690756747851;2299.4596269876565;2301.7583153768865;2275.6358982562874;2316.860988340705;2320.3271051395077;2324.4305145239355;2324.6280595104704;7561.432892533082;7953.602319883983;8233;8291.461055031465;8390.664373425056;5013.147764879943;5189.247559103909;5191.351081114861;5198.9740051299505;5203.1414816555225;3181.8886338978023;3266.5753452051317;3375.3755555222115;3427.657234276577;3439.208981934144;1018.6282007067441;1035.4563853976722;1051.2536099369456;1052.1109662335314;1057.434272664121;10404.947975260151;10691.572337106507;10717.410542420164;10827;10833.512491937881;3839.577646458887;4208.558101399371;4220.493540775065;4416.712913660666;4437.179121862466;8611.39720219591;8613.784655383666;8629.52537610425;8631.654733810577;8639.524826134497;5041.067402530543;5042.268871013683;5050.166722490748;5051.924221136685;5060.924086138711;3948.3287841067086;4060.634542891095;4121.608447197512;4743.762811859393;4744.572988431058;3583.283343331344;3585.3904836177912;3652.6712595866497;3692.9446058309145;3697.2605478904325;1087.8422628718793;1092.2900114925362;1121.433675993618;1128.8250321200228;1128.9322640641587;816.8652172391608;882.717530390269;898.5507246376811;899.9415038022638;912.6583921635186;5332.9466705333225;5469.781208751685;5478.671279723229;5801.3328467225965;5857.179994800731;950.9144177024101;965.5558443116245;973.8733964584559;993.7962717642865;994.5673631970116;3643.9089022774115;3754.887353379403;3765.962340376616;3830.71269654777;3970.265500882346;9832.115109640166;10083.336249518894;10233.232507561963;10243.436610986319;10249.33379330341;10181.33821301613;10197.74505637365;10204.23468239885;10209.234307426972;10229.07938285543;7521.7743467696055;7675.462717609714;7841;7905.802354941057;7917.722879699183;5126.359205099363;5457.154141108134;5614.775408983595;5695.288088988877;5698.943010569841;8481.787955301166;9108.908910910806;9409.388389754644;9475.431474111576;9487.857682134636;9361.251099912128;9374.156325930426;9481.715548533555;9555.761105972406;9563.330566860532;7088.751893683696;7337.192908780136;7537.9623101884135;7577.318041376303;7850.921490785247;7810.531368117704;7962.7213047543055;7964.84070318602;7973.322267607318;7979.72070977513;7033.437325013884;7037.366637002694;7158.248383919614;7198.856022879409;7253.1296244451005;6889.917813408115;6942.548734332252;6946.097007389007;7070.858582828212;7081.716731330689;6593.3736295051895;6603.702833372414;6691.698873550605;6695.163104611924;6709.966450167718;4778.952210477851;4793.18515852299;4852.296417019583;4881.219004959189;4883.072216278895;4749.715017098985;4758.119747846659;4839.491853355347;4937.777799998937;4946.010797840374 02:47:17 INFO - PROCESS | 1913 | |4;prototype.html;246.28208771431275;256.7560817223638;293.8031518882347;301.12973506566027;308.35861408270773;4811.4707382187935;5254.605904557159;5267.445289034815;5322.760475778589;5375.731213439327;4549.88625284368;4782.354382158407;4957.702537847723;5119.897602047957;5160.767765450554;3988.8005599720045;3996.8800935971967;4008.83964641414;4025.476688030552;4047;3333.599968003843;4011.59884011598;4013.1973605278913;4043.3732771420478;4061.5532291447917;3123.718865302122;3604.3692353838105;3761.9435708464393;3940.901477463072;4032.213718324928;3239.578854748891;3550.538430004096;3937.310970580137;3946.072672921861;3951.130751234724;2850.230437781808;3446.172918499567;3449.724022078228;3461.705755010827;3468.150303175713;4957.310113490797;5042.899142017176;5074;5104.515071068243;5108.923366149511;3534.8586056557706;4206.3690446432975;4473.396091527635;4512.842050528248;4530.70550414222;4392.758398288093;4464.508904020555;4790.8323208687525;5010;5432.658914767429;3326.284848757529;3562.109472631842;3813.237352529505;3839.36650452675;3848.5189351331082;5129.615352507591;5596.888062238773;5749.741261643236;5753.165790960287;5819.664350059191;3241.1687396621305;3608.2061946371755;3689.1883785567134;3875.534935807721;3888.300105980951;3530.3821831179953;3752.6434988676033;3934.291827471083;3945.849512015958;3961.3661814110183;4019.1760689059256;4153.273177193979;4409.492908315585;4450.819098641642;4606.631469482433;5444.156155795858;5504.752286147133;5539.390667026624;5552.834394586114;5561.359398977231;1026.461107918349;1063.4792247086586;1114.1699433921617;1221.3282694518157;1276.213301378078;675.6621689155422;676.8781619308473;752.7091038868367;774.2915232562256;818.5416166946529;4169.91660166801;4397.648188144941;4872.878178045577;4888;5180.352455943007;5688.07064361854;5689.829305120853;5700.7719691212715;5715.342735585377;5730.306755824756;4402.647788176938;4407.559244075567;4942.986687729007;5221.686698798084;5266.236395722599;2392.6889504364667;2545.6054311581734;2818.9154325370273;2857.285678580355;2864.7851411144247;5055.595552355802;5217.765200565984;5324.840254792362;5693.202951586781;5704.258446401941;4380.452443444569;4828.959816760472;5028.505188893684;5158.174692049254;5615.971920140455;4796.952030479651;5253.317068781034;5553.944460555343;5652.152177173457;5665.66006039639;4360.890977725456;4602.516735742699;5399.325084364455;5478.096608797344;5531.446855314436;4304.698671092993;5609.326880774333;5696.629719068413;5700.6342367918505;5737;5390.353157621111;5671.582104473881;5826.475617194473;5974.416779553335;6028.216331876828;3001.594784704037;3730.626937306248;3818.415357626554;3847.6537111658963;3858.729888907862;4859.052484765437;5608.569814697226;5726.914096288642;5738.426157384228;5771.278590176228;4683.789229484613;4815.855524334275;5268.894622107613;5584.804531841366;5657.886842263214;4817.349657796293;5228.921566176435;5290.312259406406;5529.668219906818;5655.945789273746;4091.89770255746;4594.310853372021;5269.841904742864;5439.700816455133;5475.561955043667;4418.668599855088;5409;5434.5652347812875;5472.480114389126;5593.468620481048;4949.455559888337;5253.159494480865;5481.479259470344;5492.258545096521;5522.696251706195 02:47:17 INFO - PROCESS | 1913 | |5;yui.html;753.8756105242635;772.8840673898918;775.9612019399032;777.0752804163044;778.9688412463498;14228.786568201473;14826.77759833602;14859.628509287273;14866.554003379915;14882.776758348633;14684.192369419678;14754.557363279118;14759.966802323841;14798.112113273211;14847.480338188165;657.2310396835713;676.1277951442634;819.9549024803648;842.9409941304111;844.1474111147754;808.3533173461208;829.6805729794042;839.6011894350196;843.7806170395711;845.0366582096415;880.8634661627458;886.5965985476593;886.8802711633944;887.418740724823;889.5107690770083;677.0487465111477;759.7644730133649;872.3544577013029;881.1496905486173;881.7707396077034;518.2588897876036;621.6052806467881;641.6246495799962;643.4209211709452;643.4369926314475;14071.507497237548;14110.85889141116;14118.223497707622;14135.15189088658;14140.92929535356;12500.687482812911;12597.244165350017;12732.17240879349;12852.678683032906;12943.935280323632;10929.234953553254;11468.369239691814;11552.075833933266;12045.57840475588;12258;3678.668919797231;3696.5564132304294;3715.4241092630414;3765.719655317178;3793.6775374093236;81718.59140704318;86397.13602863954;87230.563847181;88777;89549.55225223833;10384.480775961172;10458.63394781179;10494.947525262478;10562.155027597773;10605.045545900906;16885.577860553585;19509.122089506007;19725.309614163434;19872;19903.701444478345;7110.288971102952;7310.890336644955;7372.189059203483;7520.586367749826;7555.773326800205;4134.524529679125;4139.751614903115;4148.398482220122;4192.853250136231;4195.916081678411;3276.45938420158;3378.611459682168;3381.8309084545676;3382.983085084608;3383.1034775784437;630.1083966187792;649.9740010399531;662.3145044878528;667.4060086522999;668.5520701130255;591.3436085944599;672.3679741043403;674.2448457727377;674.8582797612556;675.0920012583068;8692.782680432912;8773.29813614922;9171.58727857248;9357.625694972261;9436.528173591292;637.6747858592151;644.9774257901045;653.9084528166061;677.7932730517141;679.4734081087197;4223.387608796768;4510.188166130128;4537.75042372666;4569.314602809539;4628.467726211461;85948.7107693385;88299.55850220707;117764.8223517771;123428.38285808514;126135.36932315463;65883.46284664427;69756.65121674359;108185.45907270571;108515.91484085216;109747;92067;93154.53422732843;94385.52807236057;95028.52485737528;97131.51434242925;7687.577183254974;8696.130386961253;8893.777655558662;8904.955475222583;8985.955070224607;58202.126968094664;58802;59862.40137598568;60111;61325;73122.90315645376;76827.31104411319;81642.59178704068;81672;85650.57174714087;10643.042126208678;11075.501602427748;11933.582324618945;11975.580854670045;12053.096017798525;12640.74718505643;12696.04779641549;12732.681682958;12756.115318135306;13461.596152115451;10775.730606734895;12833.743325133259;12966.157199781985;13132.73734525285;13179.472821087049;11935.82096268574;12772.680682982627;12887.35563221854;12961.82435303319;13071.477140914258;12047.821899172764;12052.758944820878;12368.010559155426;12542.310172940575;12608.621741347773;10289.74275643115;10567.365958042543;10624.36253824773;10820.783584328427;11057.557697692002;10286.691399258034;10792.622258220925;10822.350658960488;11003.889961100287;11012.449377531251 02:47:17 INFO - PROCESS | 1913 | __end_tp_report 02:47:17 INFO - PROCESS | 1913 | __start_cc_report 02:47:17 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,1362 02:47:17 INFO - PROCESS | 1913 | __end_cc_report 02:47:17 INFO - PROCESS | 1913 | __startTimestamp1484822837804__endTimestamp 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | ------- Summary: start ------- 02:47:17 INFO - PROCESS | 1913 | Number of tests: 6 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | [#0] dojo.html Cycles:165 Average:5717.60 Median:5882.50 stddev:649.74 (11.0%) stddev-sans-first:622.95 02:47:17 INFO - PROCESS | 1913 | Values: 3279.5 3297.1 3299.5 3312.4 3356.0 5625.3 5658.9 5682.3 5707.3 5716.4 5645.4 5746.0 5761.1 5762.6 5762.9 4342.8 5211.7 5236.3 5245.4 5299.7 5133.4 5150.3 5156.7 5359.8 5369.6 5196.5 5220.3 5242.2 5260.7 5262.9 5274.0 5296.9 5337.5 5343.4 5347.1 5107.2 5165.7 5262.2 5267.7 5290.1 4724.0 5651.0 5665.3 5689.1 5703.5 5117.9 6125.1 6222.9 6269.4 6286.2 6322.3 6333.9 6360.8 6361.5 6366.3 5621.4 5674.9 5691.6 5727.3 5780.0 6286.9 6299.7 6300.2 6304.7 6310.2 6116.7 6125.0 6145.0 6150.1 6152.1 6053.0 6073.4 6123.9 6164.3 6296.4 5380.7 5841.6 6123.2 6133.0 6139.1 6114.1 6121.4 6131.8 6143.4 6193.7 4934.8 4945.0 4952.2 4957.7 4975.6 4394.8 4409.6 4410.0 4415.2 4419.9 5586.8 5642.6 5653.5 5670.4 5727.7 6260.7 6299.2 6313.0 6316.9 6351.8 5687.3 5696.6 5706.8 5747.3 5753.2 5284.1 5404.6 5404.9 5415.8 5429.8 6254.4 6258.2 6275.5 6279.8 6291.7 6298.5 6307.0 6311.9 6314.5 6323.5 6189.4 6261.8 6276.9 6321.2 6344.0 6027.0 6072.0 6081.9 6120.3 6209.7 6242.7 6279.7 6287.6 6296.6 6300.8 6089.3 6094.5 6102.5 6117.2 6118.1 5882.5 5924.8 6016.4 6025.5 6067.1 5798.4 5843.4 5924.1 5977.3 5999.2 6127.3 6144.5 6145.5 6162.5 6171.4 5717.5 5815.5 5926.6 5930.3 5977.3 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | [#1] ext.html Cycles:180 Average:69064.50 Median:33748.08 stddev:157175.70 (465.7%) stddev-sans-first:157532.11 02:47:17 INFO - PROCESS | 1913 | Values: 416.8 486.9 505.8 508.3 514.0 23961.9 39051.0 40515.6 40614.8 42475.4 41704.0 42052.0 42171.6 42184.0 42254.4 8151.4 9130.3 9307.7 9318.3 9354.5 8178.9 10918.8 11205.6 11209.4 11213.8 10763.8 10860.8 10887.5 10915.6 10930.6 10936.2 11011.9 11024.6 11046.6 11078.5 10904.5 10973.7 10978.6 10995.0 11018.8 37798.1 38203.0 38234.6 38254.6 38346.0 3187.0 3194.1 3224.0 3347.2 3509.0 28040.3 28186.4 28429.0 28517.7 28964.9 2769.5 3135.7 3187.5 3200.0 3250.8 476346.0 479608.0 479650.0 480168.0 480358.0 32659.3 33413.7 54527.0 54903.5 55040.4 35353.5 35448.6 35477.3 35510.8 35597.5 12190.8 14250.5 14392.5 14438.0 14440.2 11072.7 11320.0 11339.9 12012.7 12065.0 7396.5 7448.9 7452.7 7458.5 7650.3 3184.6 3208.3 3223.4 3232.7 3242.4 859.7 886.9 940.9 1011.5 1023.8 28784.6 29518.6 29671.9 30339.7 30399.5 902.7 935.4 1006.4 1020.4 1074.2 15273.8 15338.1 15402.5 15568.1 15644.2 670180.1 678298.0 679011.4 679188.6 679692.0 57715.0 58344.7 58388.4 58443.7 58522.1 1322.2 1357.3 1375.3 1377.8 1381.6 28050.6 28243.6 28888.8 29317.7 29563.6 47164.3 47477.8 47560.0 47577.8 47581.0 582510.0 583704.0 584006.0 585585.0 587040.0 24611.6 25571.6 25613.0 25646.4 25651.4 37340.0 43582.8 45033.3 46264.5 47216.5 36049.3 36245.1 37361.0 38313.4 39607.2 37957.0 38477.4 39170.6 39517.4 39695.8 29534.0 36013.1 36434.3 36472.8 37285.0 32199.4 32239.0 33593.5 33720.5 33775.7 24728.5 24906.9 25012.2 25172.2 25333.7 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | [#2] jquery.html Cycles:180 Average:32617.41 Median:344.45 stddev:95338.60 (27678.5%) stddev-sans-first:95575.22 02:47:17 INFO - PROCESS | 1913 | Values: 329.3 359.6 367.3 372.5 390.3 18737.0 19419.3 19485.2 20541.0 20732.3 15529.2 18191.3 20215.4 20748.0 20816.4 5542.9 5788.6 5789.5 5792.4 5807.1 5414.0 5700.2 5761.3 5764.6 5768.6 5557.6 5715.6 5722.9 5728.8 5740.1 5542.6 5666.9 5694.3 5703.3 5709.5 4853.4 4948.6 4995.6 5012.7 5020.7 20472.9 24848.8 25007.9 25037.0 25312.6 2251.7 2253.1 2316.9 2406.1 2410.5 14865.0 15242.8 15244.8 15343.7 16030.0 1783.6 1828.5 1840.2 1871.4 1879.1 114748.4 115736.4 116354.4 118346.0 119104.0 10345.3 10575.4 10787.7 10911.1 11036.2 13492.8 13503.4 13546.8 13550.3 13627.1 8165.6 8362.6 8365.3 8465.4 8481.1 8382.3 8394.5 8415.7 8519.1 8552.0 5626.9 6532.0 6595.1 6607.3 6750.1 1712.7 1788.0 1790.3 1793.2 1794.6 928.8 971.6 993.9 1001.9 1079.6 20079.3 20304.4 21396.7 21949.9 21994.8 945.7 945.8 945.9 950.9 960.5 9685.0 10850.7 10948.9 11299.5 11587.7 515830.0 583519.0 586585.0 591423.0 600235.0 57451.7 57549.0 65660.0 105158.5 105605.0 876.4 956.8 984.8 986.6 988.8 18947.3 19847.9 19850.4 19923.3 20077.7 46270.5 49026.0 49554.8 51046.9 52905.7 65877.7 69738.0 70182.9 70504.6 73249.6 6887.6 7106.8 7235.9 7255.4 7438.7 9321.6 12222.4 12313.2 12404.5 12577.7 10556.8 10795.1 10886.1 11195.8 11198.2 8745.3 10436.5 10594.8 10661.3 10993.0 10897.2 11036.3 11269.7 11333.3 11404.3 7238.6 7389.3 7395.7 7418.3 7594.1 8446.5 10865.9 10882.8 11250.5 11267.3 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | [#3] mootools.html Cycles:180 Average:5388.34 Median:5041.67 stddev:2957.88 (58.7%) stddev-sans-first:2951.44 02:47:17 INFO - PROCESS | 1913 | Values: 1459.0 1498.4 1637.6 1811.6 1819.4 7984.5 8386.8 8393.7 8394.5 8402.9 7419.6 7660.7 7671.2 8033.7 8185.0 2265.6 2305.7 2312.2 2313.0 2313.2 2297.5 2310.1 2321.8 2344.6 2347.3 2277.2 2284.8 2303.6 2304.9 2316.4 2272.5 2286.3 2290.7 2299.5 2301.8 2275.6 2316.9 2320.3 2324.4 2324.6 7561.4 7953.6 8233.0 8291.5 8390.7 5013.1 5189.2 5191.4 5199.0 5203.1 3181.9 3266.6 3375.4 3427.7 3439.2 1018.6 1035.5 1051.3 1052.1 1057.4 10404.9 10691.6 10717.4 10827.0 10833.5 3839.6 4208.6 4220.5 4416.7 4437.2 8611.4 8613.8 8629.5 8631.7 8639.5 5041.1 5042.3 5050.2 5051.9 5060.9 3948.3 4060.6 4121.6 4743.8 4744.6 3583.3 3585.4 3652.7 3692.9 3697.3 1087.8 1092.3 1121.4 1128.8 1128.9 816.9 882.7 898.6 899.9 912.7 5332.9 5469.8 5478.7 5801.3 5857.2 950.9 965.6 973.9 993.8 994.6 3643.9 3754.9 3766.0 3830.7 3970.3 9832.1 10083.3 10233.2 10243.4 10249.3 10181.3 10197.7 10204.2 10209.2 10229.1 7521.8 7675.5 7841.0 7905.8 7917.7 5126.4 5457.2 5614.8 5695.3 5698.9 8481.8 9108.9 9409.4 9475.4 9487.9 9361.3 9374.2 9481.7 9555.8 9563.3 7088.8 7337.2 7538.0 7577.3 7850.9 7810.5 7962.7 7964.8 7973.3 7979.7 7033.4 7037.4 7158.2 7198.9 7253.1 6889.9 6942.5 6946.1 7070.9 7081.7 6593.4 6603.7 6691.7 6695.2 6710.0 4779.0 4793.2 4852.3 4881.2 4883.1 4749.7 4758.1 4839.5 4937.8 4946.0 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | [#4] prototype.html Cycles:180 Average:4360.19 Median:4823.15 stddev:1380.05 (28.6%) stddev-sans-first:1348.93 02:47:17 INFO - PROCESS | 1913 | Values: 246.3 256.8 293.8 301.1 308.4 4811.5 5254.6 5267.4 5322.8 5375.7 4549.9 4782.4 4957.7 5119.9 5160.8 3988.8 3996.9 4008.8 4025.5 4047.0 3333.6 4011.6 4013.2 4043.4 4061.6 3123.7 3604.4 3761.9 3940.9 4032.2 3239.6 3550.5 3937.3 3946.1 3951.1 2850.2 3446.2 3449.7 3461.7 3468.2 4957.3 5042.9 5074.0 5104.5 5108.9 3534.9 4206.4 4473.4 4512.8 4530.7 4392.8 4464.5 4790.8 5010.0 5432.7 3326.3 3562.1 3813.2 3839.4 3848.5 5129.6 5596.9 5749.7 5753.2 5819.7 3241.2 3608.2 3689.2 3875.5 3888.3 3530.4 3752.6 3934.3 3945.8 3961.4 4019.2 4153.3 4409.5 4450.8 4606.6 5444.2 5504.8 5539.4 5552.8 5561.4 1026.5 1063.5 1114.2 1221.3 1276.2 675.7 676.9 752.7 774.3 818.5 4169.9 4397.6 4872.9 4888.0 5180.4 5688.1 5689.8 5700.8 5715.3 5730.3 4402.6 4407.6 4943.0 5221.7 5266.2 2392.7 2545.6 2818.9 2857.3 2864.8 5055.6 5217.8 5324.8 5693.2 5704.3 4380.5 4829.0 5028.5 5158.2 5616.0 4797.0 5253.3 5553.9 5652.2 5665.7 4360.9 4602.5 5399.3 5478.1 5531.4 4304.7 5609.3 5696.6 5700.6 5737.0 5390.4 5671.6 5826.5 5974.4 6028.2 3001.6 3730.6 3818.4 3847.7 3858.7 4859.1 5608.6 5726.9 5738.4 5771.3 4683.8 4815.9 5268.9 5584.8 5657.9 4817.3 5228.9 5290.3 5529.7 5655.9 4091.9 4594.3 5269.8 5439.7 5475.6 4418.7 5409.0 5434.6 5472.5 5593.5 4949.5 5253.2 5481.5 5492.3 5522.7 02:47:17 INFO - PROCESS | 1913 | 02:47:17 INFO - PROCESS | 1913 | [#5] yui.html Cycles:180 Average:20830.96 Median:4209.65 stddev:31015.66 (736.8%) stddev-sans-first:31066.03 02:47:17 INFO - PROCESS | 1913 | Values: 753.9 772.9 776.0 777.1 779.0 14228.8 14826.8 14859.6 14866.6 14882.8 14684.2 14754.6 14760.0 14798.1 14847.5 657.2 676.1 820.0 842.9 844.1 808.4 829.7 839.6 843.8 845.0 880.9 886.6 886.9 887.4 889.5 677.0 759.8 872.4 881.1 881.8 518.3 621.6 641.6 643.4 643.4 14071.5 14110.9 14118.2 14135.2 14140.9 12500.7 12597.2 12732.2 12852.7 12943.9 10929.2 11468.4 11552.1 12045.6 12258.0 3678.7 3696.6 3715.4 3765.7 3793.7 81718.6 86397.1 87230.6 88777.0 89549.6 10384.5 10458.6 10494.9 10562.2 10605.0 16885.6 19509.1 19725.3 19872.0 19903.7 7110.3 7310.9 7372.2 7520.6 7555.8 4134.5 4139.8 4148.4 4192.9 4195.9 3276.5 3378.6 3381.8 3383.0 3383.1 630.1 650.0 662.3 667.4 668.6 591.3 672.4 674.2 674.9 675.1 8692.8 8773.3 9171.6 9357.6 9436.5 637.7 645.0 653.9 677.8 679.5 4223.4 4510.2 4537.8 4569.3 4628.5 85948.7 88299.6 117764.8 123428.4 126135.4 65883.5 69756.7 108185.5 108515.9 109747.0 92067.0 93154.5 94385.5 95028.5 97131.5 7687.6 8696.1 8893.8 8905.0 8986.0 58202.1 58802.0 59862.4 60111.0 61325.0 73122.9 76827.3 81642.6 81672.0 85650.6 10643.0 11075.5 11933.6 11975.6 12053.1 12640.7 12696.0 12732.7 12756.1 13461.6 10775.7 12833.7 12966.2 13132.7 13179.5 11935.8 12772.7 12887.4 12961.8 13071.5 12047.8 12052.8 12368.0 12542.3 12608.6 10289.7 10567.4 10624.4 10820.8 11057.6 10286.7 10792.6 10822.4 11003.9 11012.4 02:47:17 INFO - PROCESS | 1913 | -------- Summary: end -------- 02:47:17 INFO - PROCESS | 1913 | 02:47:18 INFO - TEST-INFO | 1913: exit 0 02:47:18 INFO - TEST-OK | dromaeo_css | took 1119143ms 02:47:18 INFO - TEST-START | kraken 02:47:18 INFO - operating with platform_type : mac_ 02:47:18 INFO - Initialising browser for kraken test... 02:47:18 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpTiKpNs/profile http://localhost:51490/getInfo.html) 02:47:20 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 02:47:20 INFO - PROCESS | 1918 | colorDepth:24 02:47:20 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 02:47:20 INFO - PROCESS | 1918 | __metrics 02:47:21 INFO - PROCESS | 1918 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:47:21 INFO - PROCESS | 1918 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:22 INFO - TEST-INFO | 1918: exit 0 02:47:22 INFO - Browser initialized. 02:47:22 INFO - Running cycle 1/1 for kraken test... 02:47:22 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpTiKpNs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:34 INFO - PROCESS | 1920 | RSS: Main: 221863936 02:47:34 INFO - PROCESS | 1920 | 02:47:37 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:38 INFO - PROCESS | 1920 | RSS: Main: 273891328 02:47:38 INFO - PROCESS | 1920 | 02:47:40 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-dft) 02:47:41 INFO - PROCESS | 1920 | RSS: Main: 284835840 02:47:41 INFO - PROCESS | 1920 | 02:47:44 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-fft) 02:47:45 INFO - PROCESS | 1920 | RSS: Main: 381239296 02:47:45 INFO - PROCESS | 1920 | 02:47:47 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-oscillator) 02:47:47 INFO - PROCESS | 1920 | RSS: Main: 283152384 02:47:47 INFO - PROCESS | 1920 | 02:47:49 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:50 INFO - PROCESS | 1920 | RSS: Main: 284262400 02:47:50 INFO - PROCESS | 1920 | 02:47:53 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51490/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:53 INFO - PROCESS | 1920 | RSS: Main: 324878336 02:47:53 INFO - PROCESS | 1920 | 02:47:56 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51490/tests/kraken/driver.html?testName=imaging-desaturate) 02:47:57 INFO - PROCESS | 1920 | RSS: Main: 326344704 02:47:57 INFO - PROCESS | 1920 | 02:48:00 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51490/tests/kraken/driver.html?testName=json-parse-financial) 02:48:01 INFO - PROCESS | 1920 | RSS: Main: 324980736 02:48:01 INFO - PROCESS | 1920 | 02:48:02 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:03 INFO - PROCESS | 1920 | RSS: Main: 298840064 02:48:03 INFO - PROCESS | 1920 | 02:48:05 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:05 INFO - PROCESS | 1920 | RSS: Main: 299950080 02:48:05 INFO - PROCESS | 1920 | 02:48:07 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:08 INFO - PROCESS | 1920 | RSS: Main: 302923776 02:48:08 INFO - PROCESS | 1920 | 02:48:11 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:12 INFO - PROCESS | 1920 | RSS: Main: 320512000 02:48:12 INFO - PROCESS | 1920 | 02:48:15 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:15 INFO - PROCESS | 1920 | RSS: Main: 314511360 02:48:15 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51490/tests/kraken/driver.html?testName=ai-astar) 02:48:17 INFO - PROCESS | 1920 | RSS: Main: 358526976 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | __start_tp_report 02:48:17 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 02:48:17 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 02:48:17 INFO - PROCESS | 1920 | |i|pagename|runs| 02:48:17 INFO - PROCESS | 1920 | |0;ai-astar;117;124;168;153;115;114;114;116;116;115 02:48:17 INFO - PROCESS | 1920 | |1;audio-beat-detection;144;103;129;176;139;118;111;113;141;113 02:48:17 INFO - PROCESS | 1920 | |2;audio-dft;184;184;186;198;262;204;181;184;185;184 02:48:17 INFO - PROCESS | 1920 | |3;audio-fft;85;59;59;91;79;83;81;71;82;59 02:48:17 INFO - PROCESS | 1920 | |4;audio-oscillator;90;71;95;67;67;69;89;67;68;91 02:48:17 INFO - PROCESS | 1920 | |5;imaging-gaussian-blur;90;87;91;88;91;86;91;88;89;87 02:48:17 INFO - PROCESS | 1920 | |6;imaging-darkroom;99;99;99;99;99;112;154;106;98;99 02:48:17 INFO - PROCESS | 1920 | |7;imaging-desaturate;125;123;124;78;85;82;83;86;82;83 02:48:17 INFO - PROCESS | 1920 | |8;json-parse-financial;55;54;54;54;57;59;58;57;58;57 02:48:17 INFO - PROCESS | 1920 | |9;json-stringify-tinderbox;66;67;76;77;73;71;71;74;73;74 02:48:17 INFO - PROCESS | 1920 | |10;stanford-crypto-aes;83;84;84;83;84;84;83;84;84;84 02:48:17 INFO - PROCESS | 1920 | |11;stanford-crypto-ccm;140;140;141;138;140;144;144;144;186;139 02:48:17 INFO - PROCESS | 1920 | |12;stanford-crypto-pbkdf2;167;166;167;222;213;165;166;165;165;166 02:48:17 INFO - PROCESS | 1920 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;67;67;69;66;67 02:48:17 INFO - PROCESS | 1920 | __end_tp_report 02:48:17 INFO - PROCESS | 1920 | __start_cc_report 02:48:17 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,1964 02:48:17 INFO - PROCESS | 1920 | __end_cc_report 02:48:17 INFO - PROCESS | 1920 | __startTimestamp1484822897784__endTimestamp 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | ------- Summary: start ------- 02:48:17 INFO - PROCESS | 1920 | Number of tests: 14 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#0] ai-astar Cycles:10 Average:125.20 Median:116.50 stddev:19.15 (16.4%) stddev-sans-first:20.08 02:48:17 INFO - PROCESS | 1920 | Values: 117.0 124.0 168.0 153.0 115.0 114.0 114.0 116.0 116.0 115.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:134.00 stddev:21.88 (16.3%) stddev-sans-first:22.50 02:48:17 INFO - PROCESS | 1920 | Values: 144.0 103.0 129.0 176.0 139.0 118.0 111.0 113.0 141.0 113.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#2] audio-dft Cycles:10 Average:195.20 Median:185.50 stddev:24.58 (13.3%) stddev-sans-first:25.74 02:48:17 INFO - PROCESS | 1920 | Values: 184.0 184.0 186.0 198.0 262.0 204.0 181.0 184.0 185.0 184.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#3] audio-fft Cycles:10 Average:74.90 Median:81.50 stddev:12.04 (14.8%) stddev-sans-first:12.20 02:48:17 INFO - PROCESS | 1920 | Values: 85.0 59.0 59.0 91.0 79.0 83.0 81.0 71.0 82.0 59.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:80.00 stddev:12.08 (15.1%) stddev-sans-first:11.92 02:48:17 INFO - PROCESS | 1920 | Values: 90.0 71.0 95.0 67.0 67.0 69.0 89.0 67.0 68.0 91.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.50 stddev:1.87 (2.1%) stddev-sans-first:1.94 02:48:17 INFO - PROCESS | 1920 | Values: 90.0 87.0 91.0 88.0 91.0 86.0 91.0 88.0 89.0 87.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:99.00 stddev:17.31 (17.5%) stddev-sans-first:18.15 02:48:17 INFO - PROCESS | 1920 | Values: 99.0 99.0 99.0 99.0 99.0 112.0 154.0 106.0 98.0 99.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:82.50 stddev:20.06 (24.3%) stddev-sans-first:18.12 02:48:17 INFO - PROCESS | 1920 | Values: 125.0 123.0 124.0 78.0 85.0 82.0 83.0 86.0 82.0 83.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.89 (3.3%) stddev-sans-first:1.94 02:48:17 INFO - PROCESS | 1920 | Values: 55.0 54.0 54.0 54.0 57.0 59.0 58.0 57.0 58.0 57.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:73.50 stddev:3.55 (4.8%) stddev-sans-first:2.98 02:48:17 INFO - PROCESS | 1920 | Values: 66.0 67.0 76.0 77.0 73.0 71.0 71.0 74.0 73.0 74.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 02:48:17 INFO - PROCESS | 1920 | Values: 83.0 84.0 84.0 83.0 84.0 84.0 83.0 84.0 84.0 84.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:142.50 stddev:14.36 (10.1%) stddev-sans-first:15.09 02:48:17 INFO - PROCESS | 1920 | Values: 140.0 140.0 141.0 138.0 140.0 144.0 144.0 144.0 186.0 139.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:166.50 stddev:21.88 (13.1%) stddev-sans-first:22.96 02:48:17 INFO - PROCESS | 1920 | Values: 167.0 166.0 167.0 222.0 213.0 165.0 166.0 165.0 165.0 166.0 02:48:17 INFO - PROCESS | 1920 | 02:48:17 INFO - PROCESS | 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 02:48:17 INFO - PROCESS | 1920 | Values: 68.0 68.0 68.0 67.0 67.0 67.0 67.0 69.0 66.0 67.0 02:48:17 INFO - PROCESS | 1920 | -------- Summary: end -------- 02:48:17 INFO - PROCESS | 1920 | 02:48:18 INFO - TEST-INFO | 1920: exit 0 02:48:18 INFO - TEST-OK | kraken | took 60394ms 02:48:18 INFO - SUITE-END | took 1179s 02:48:18 INFO - Completed test suite (00:19:39) 02:48:18 INFO - javascript benchmark 02:48:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.524468952002, 3297.0768184908225, 3299.4555898276785, 3312.3540909522653, 3355.983220083899, 5625.296837895263, 5658.886822263552, 5682.346530149034, 5707.315122185333, 5716.428357164286, 5645.435456454353, 5745.971270143644, 5761.078227483604, 5762.56780741445, 5762.855928601787, 4342.826286948526, 5211.661242019257, 5236.266922630834, 5245.370555533342, 5299.6820190788485, 5133.383993920735, 5150.33045704058, 5156.742162891859, 5359.812406565771, 5369.570434365261, 5196.454372290912, 5220.295260139889, 5242.161254199329, 5260.684358938457, 5262.947370526284, 5274.024305503494, 5296.92054619181, 5337.492938170868, 5343.385510666245, 5347.0909945309395, 5107.157319042353, 5165.741712914377, 5262.236975638511, 5267.736613169326, 5290.100682883919, 4724.0, 5651.0, 5665.291838520185, 5689.118186681071, 5703.458171473703, 5117.897642047138, 6125.142480052797, 6222.906656400158, 6269.435750782406, 6286.214223222098, 6322.272938612026, 6333.87332253357, 6360.840978975516, 6361.491080713532, 6366.299707032223, 5621.381648018673, 5674.943250567524, 5691.573132015033, 5727.341355744059, 5779.959607270732, 6286.9056964145575, 6299.6850157491945, 6300.21247344082, 6304.65324407162, 6310.211223597051, 6116.694165291718, 6124.989376752786, 6145.016797312409, 6150.138980542728, 6152.107944348134, 6053.031514957585, 6073.423024812636, 6123.923256659767, 6164.260288765287, 6296.433321001132, 5380.735527151116, 5841.620294680833, 6123.203983482119, 6133.049377346519, 6139.140520327158, 6114.062842019308, 6121.357257487989, 6131.774283661951, 6143.43342447673, 6193.721282542297, 4934.777934992934, 4945.0, 4952.182889823211, 4957.677750946177, 4975.601951843843, 4394.846180383671, 4409.581089796464, 4409.977950110229, 4415.249407600716, 4419.889502762392, 5586.776528938797, 5642.605017648807, 5653.547716182778, 5670.376258611549, 5727.713614319267, 6260.655663938436, 6299.244090709052, 6312.968435157886, 6316.873662526724, 6351.777687780906, 5687.317521897398, 5696.601237913306, 5706.771729130788, 5747.281589801275, 5753.223314852441, 5284.101702710548, 5404.621676482609, 5404.891902162013, 5415.783368665209, 5429.782808687687, 6254.437100660781, 6258.249010118815, 6275.466585340206, 6279.780207692709, 6291.685415729104, 6298.496120310272, 6306.9684651576445, 6311.90532142009, 6314.494840412848, 6323.494120470259, 6189.35011823752, 6261.843453913506, 6276.874462510816, 6321.209848768904, 6344.0, 6027.0, 6071.9981203101, 6081.878362432638, 6120.296165940974, 6209.689515524115, 6242.65665388408, 6279.654618995816, 6287.622742635456, 6296.590721603265, 6300.779472718433, 6089.330173680803, 6094.451499365078, 6102.481289090477, 6117.235345581802, 6118.051701986199, 5882.499987500939, 5924.763009479572, 6016.368281330398, 6025.548083893813, 6067.12026756109, 5798.420157984167, 5843.386444423274, 5924.081767326072, 5977.282726072899, 5999.1601175836295, 6127.264728232641, 6144.508439324933, 6145.477634400947, 6162.537809664203, 6171.444569988723, 5717.542596592346, 5815.505682017076, 5926.644401335933, 5930.28836539618, 5977.252843394575], "value": 5675.649755330093, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.8311833707349, 486.89775147219086, 505.7547089661513, 508.2883962452568, 513.9643618109508, 23961.880190599044, 39051.0, 40515.59484405155, 40614.796926015326, 42475.36286955698, 41704.0, 42052.0, 42171.57828421715, 42184.0, 42254.36618450726, 8151.388645851555, 9130.269578433727, 9307.72076837696, 9318.347715659907, 9354.532273386338, 8178.918210817875, 10918.781624367508, 11205.60780372683, 11209.383483908381, 11213.831792523119, 10763.83854242187, 10860.782784344308, 10887.455627218607, 10915.563377464892, 10930.56277748889, 10936.179786516004, 11011.889881101166, 11024.559017639285, 11046.613368532144, 11078.501467433985, 10904.454777261184, 10973.670789876316, 10978.615748448767, 10995.010449059542, 11018.779624407467, 37798.055048624, 38203.04492387685, 38234.617653823385, 38254.61745382538, 38346.0, 3186.9521957170427, 3194.0896844399235, 3223.9677603223904, 3347.163209197701, 3508.9648553676725, 28040.298992525146, 28186.43627127446, 28429.00498482564, 28517.714822851714, 28964.8551757242, 2769.5014897318474, 3135.702108299708, 3187.505936579834, 3200.0398386534443, 3250.7886987345746, 476346.0, 479608.0, 479649.9999999965, 480168.0, 480358.0, 32659.34681306408, 33413.66586334154, 54527.0, 54903.450965490636, 55040.44959550353, 35353.46969795455, 35448.64551354505, 35477.29045419077, 35510.82244588812, 35597.46603800945, 12190.75618487643, 14250.501232456814, 14392.496262630757, 14438.0, 14440.205788681513, 11072.723181920517, 11320.037796787365, 11339.886601134049, 12012.699682508008, 12064.974477169364, 7396.519226250277, 7448.925510744932, 7452.739154129579, 7458.477906546598, 7650.31147196755, 3184.617845858512, 3208.278137419062, 3223.3553289342226, 3232.69289417505, 3242.4001559711055, 859.6987567739909, 886.9068747781519, 940.9200217981548, 1011.544804837826, 1023.8003589300164, 28784.568231476544, 29518.557221641262, 29671.85164074209, 30339.69660303413, 30399.544006839915, 902.7291812456236, 935.3592788939599, 1006.3710181136789, 1020.3928662445833, 1074.237291523012, 15273.770893436607, 15338.0797152169, 15402.537923862303, 15568.143752093518, 15644.217789110498, 670180.1400922996, 678298.0, 679011.4197716018, 679188.6040569765, 679692.0, 57715.0, 58344.7082764592, 58388.4161158383, 58443.70778146167, 58522.12216816751, 1322.1604281281454, 1357.2670757790681, 1375.2504884837588, 1377.8415482219473, 1381.5717127690448, 28050.57924131099, 28243.576346355232, 28888.844446221916, 29317.706822932352, 29563.600185978026, 47164.292535611305, 47477.76261118672, 47560.04879902452, 47577.76211118922, 47581.0, 582510.0, 583704.0, 584006.0, 585585.0, 587040.0, 24611.630825537988, 25571.61642575326, 25613.0, 25646.358841029123, 25651.35871603225, 37340.0, 43582.78208608937, 45033.32450013318, 46264.53735462737, 47216.527834721215, 36049.27901442009, 36245.09387265339, 37361.0, 38313.4252986211, 39607.20785584215, 37957.0, 38477.422838658, 39170.608293916695, 39517.40723889202, 39695.80152099221, 29534.0, 36013.0996725084, 36434.27131457409, 36472.81763591165, 37285.0, 32199.35601288008, 32239.032829015166, 33593.49609755807, 33720.49419258664, 33775.66224337823, 24728.505429891662, 24906.875465622557, 25012.2427767618, 25172.24483265505, 25333.746662533875], "value": 18307.81734108272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.27887925443264, 359.6206002667186, 367.32779014403644, 372.48968912589754, 390.3461701649738, 18737.0, 19419.32032378867, 19485.22059117637, 20541.0, 20732.27437039704, 15529.22353882307, 18191.272349106053, 20215.393538193843, 20748.0, 20816.375508734724, 5542.91685624716, 5788.5658575606785, 5789.536837053047, 5792.4497172768515, 5807.070868661015, 5414.0, 5700.201971723962, 5761.308642962829, 5764.625299355549, 5768.567357448187, 5557.638753481031, 5715.571332150084, 5722.885542289152, 5728.770849166029, 5740.052891272935, 5542.5565954723525, 5666.914996275059, 5694.259746233005, 5703.344115426696, 5709.486146246858, 4853.4418541867435, 4948.572393482042, 4995.5753760930365, 5012.674176178573, 5020.748962551895, 20472.897635511727, 24848.751512484825, 25007.874960625264, 25037.0, 25312.620310695354, 2251.7072780538588, 2253.1100215414817, 2316.9189078382174, 2406.0736616402637, 2410.5419970205603, 14864.959452838306, 15242.771358429633, 15244.771328430083, 15343.693126137414, 16030.038197708174, 1783.6343549572307, 1828.469743774317, 1840.1627259596985, 1871.3824437935448, 1879.1074239736154, 114748.42625786818, 115736.42131789288, 116354.41822790832, 118346.0, 119104.0, 10345.275830691779, 10575.41835199056, 10787.730306742395, 10911.127109831194, 11036.227464077438, 13492.797608035888, 13503.392347344394, 13546.796798048037, 13550.322483875767, 13627.114237574526, 8165.63254653542, 8362.623681934327, 8365.330773538102, 8465.365097617703, 8481.109483504266, 8382.329413646894, 8394.496330220207, 8415.705450309331, 8519.148085191431, 8551.957240213884, 5626.943730562723, 6532.0, 6595.142631457879, 6607.2651141561455, 6750.088738020305, 1712.6917154911987, 1788.025526088285, 1790.3017823049022, 1793.2199493220492, 1794.641071785622, 928.767808047988, 971.6259240192577, 993.8608594796734, 1001.9198464122853, 1079.5681727308981, 20079.29722459736, 20304.39086827368, 21396.679049814265, 21949.90250487469, 21994.780052199592, 945.6879229854131, 945.8486642137225, 945.9385139966017, 950.8811398575178, 960.500539719342, 9685.0, 10850.67447976562, 10948.945255273831, 11299.49152288149, 11587.710307242387, 515830.0, 583519.0, 586585.0, 591423.0, 600235.0, 57451.71274143602, 57549.0, 65660.0, 105158.47420762847, 105605.0, 876.4434584039182, 956.8229877472829, 984.7636567223958, 986.6448078691665, 988.8220120378401, 18947.33684321042, 19847.900760496683, 19850.404487865388, 19923.302684405975, 20077.698834517785, 46270.53729462797, 49026.0, 49554.75222623864, 51046.93718376909, 52905.7354713224, 65877.67061164664, 69738.0, 70182.94725579223, 70504.64747676229, 73249.6337518309, 6887.621180835102, 7106.822329441805, 7235.927640723526, 7255.383292419992, 7438.702451901863, 9321.580528876353, 12222.449989750305, 12313.199642023239, 12404.503819847105, 12577.748445030866, 10556.84164737545, 10795.082417994558, 10886.074683651977, 11195.776084478428, 11198.16013798952, 8745.344099192458, 10436.478176091317, 10594.788104237718, 10661.307015043998, 10993.010629043425, 10897.237193396386, 11036.337819730841, 11269.71825704364, 11333.26333788301, 11404.289356596577, 7238.6018768968215, 7389.298016688406, 7395.704171833282, 7418.332350088518, 7594.126675432175, 8446.450980686235, 10865.891341086488, 10882.836757448804, 11250.549978001116, 11267.323960562393], "value": 9335.273916402624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.993294626708, 1498.4006397441021, 1637.557859377968, 1811.6376724655072, 1819.4359748477973, 7984.520928744279, 8386.832263354729, 8393.748187554367, 8394.454360466565, 8402.91597084029, 7419.591922444277, 7660.693572257117, 7671.232876712326, 8033.678652853893, 8184.959075204631, 2265.5921934051903, 2305.6772051912744, 2312.236961802601, 2313.0, 2313.190383365817, 2297.540491901618, 2310.1221535816367, 2321.8258630602772, 2344.5662552427857, 2347.272345572878, 2277.1574517428576, 2284.805791507724, 2303.562323158603, 2304.8962796674105, 2316.3514216019457, 2272.5000499889998, 2286.325533967484, 2290.690756747851, 2299.4596269876565, 2301.7583153768865, 2275.6358982562874, 2316.860988340705, 2320.3271051395077, 2324.4305145239355, 2324.6280595104704, 7561.432892533082, 7953.602319883983, 8233.0, 8291.461055031465, 8390.664373425056, 5013.147764879943, 5189.247559103909, 5191.351081114861, 5198.9740051299505, 5203.1414816555225, 3181.8886338978023, 3266.5753452051317, 3375.3755555222115, 3427.657234276577, 3439.208981934144, 1018.6282007067441, 1035.4563853976722, 1051.2536099369456, 1052.1109662335314, 1057.434272664121, 10404.947975260151, 10691.572337106507, 10717.410542420164, 10827.0, 10833.512491937881, 3839.577646458887, 4208.558101399371, 4220.493540775065, 4416.712913660666, 4437.179121862466, 8611.39720219591, 8613.784655383666, 8629.52537610425, 8631.654733810577, 8639.524826134497, 5041.067402530543, 5042.268871013683, 5050.166722490748, 5051.924221136685, 5060.924086138711, 3948.3287841067086, 4060.634542891095, 4121.608447197512, 4743.762811859393, 4744.572988431058, 3583.283343331344, 3585.3904836177912, 3652.6712595866497, 3692.9446058309145, 3697.2605478904325, 1087.8422628718793, 1092.2900114925362, 1121.433675993618, 1128.8250321200228, 1128.9322640641587, 816.8652172391608, 882.717530390269, 898.5507246376811, 899.9415038022638, 912.6583921635186, 5332.9466705333225, 5469.781208751685, 5478.671279723229, 5801.3328467225965, 5857.179994800731, 950.9144177024101, 965.5558443116245, 973.8733964584559, 993.7962717642865, 994.5673631970116, 3643.9089022774115, 3754.887353379403, 3765.962340376616, 3830.71269654777, 3970.265500882346, 9832.115109640166, 10083.336249518894, 10233.232507561963, 10243.436610986319, 10249.33379330341, 10181.33821301613, 10197.74505637365, 10204.23468239885, 10209.234307426972, 10229.07938285543, 7521.7743467696055, 7675.462717609714, 7841.0, 7905.802354941057, 7917.722879699183, 5126.359205099363, 5457.154141108134, 5614.775408983595, 5695.288088988877, 5698.943010569841, 8481.787955301166, 9108.908910910806, 9409.388389754644, 9475.431474111576, 9487.857682134636, 9361.251099912128, 9374.156325930426, 9481.715548533555, 9555.761105972406, 9563.330566860532, 7088.751893683696, 7337.192908780136, 7537.9623101884135, 7577.318041376303, 7850.921490785247, 7810.531368117704, 7962.7213047543055, 7964.84070318602, 7973.322267607318, 7979.72070977513, 7033.437325013884, 7037.366637002694, 7158.248383919614, 7198.856022879409, 7253.1296244451005, 6889.917813408115, 6942.548734332252, 6946.097007389007, 7070.858582828212, 7081.716731330689, 6593.3736295051895, 6603.702833372414, 6691.698873550605, 6695.163104611924, 6709.966450167718, 4778.952210477851, 4793.18515852299, 4852.296417019583, 4881.219004959189, 4883.072216278895, 4749.715017098985, 4758.119747846659, 4839.491853355347, 4937.777799998937, 4946.010797840374], "value": 4369.0651037470525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [246.28208771431275, 256.7560817223638, 293.8031518882347, 301.12973506566027, 308.35861408270773, 4811.4707382187935, 5254.605904557159, 5267.445289034815, 5322.760475778589, 5375.731213439327, 4549.88625284368, 4782.354382158407, 4957.702537847723, 5119.897602047957, 5160.767765450554, 3988.8005599720045, 3996.8800935971967, 4008.83964641414, 4025.476688030552, 4047.0, 3333.599968003843, 4011.59884011598, 4013.1973605278913, 4043.3732771420478, 4061.5532291447917, 3123.718865302122, 3604.3692353838105, 3761.9435708464393, 3940.901477463072, 4032.213718324928, 3239.578854748891, 3550.538430004096, 3937.310970580137, 3946.072672921861, 3951.130751234724, 2850.230437781808, 3446.172918499567, 3449.724022078228, 3461.705755010827, 3468.150303175713, 4957.310113490797, 5042.899142017176, 5074.0, 5104.515071068243, 5108.923366149511, 3534.8586056557706, 4206.3690446432975, 4473.396091527635, 4512.842050528248, 4530.70550414222, 4392.758398288093, 4464.508904020555, 4790.8323208687525, 5010.0, 5432.658914767429, 3326.284848757529, 3562.109472631842, 3813.237352529505, 3839.36650452675, 3848.5189351331082, 5129.615352507591, 5596.888062238773, 5749.741261643236, 5753.165790960287, 5819.664350059191, 3241.1687396621305, 3608.2061946371755, 3689.1883785567134, 3875.534935807721, 3888.300105980951, 3530.3821831179953, 3752.6434988676033, 3934.291827471083, 3945.849512015958, 3961.3661814110183, 4019.1760689059256, 4153.273177193979, 4409.492908315585, 4450.819098641642, 4606.631469482433, 5444.156155795858, 5504.752286147133, 5539.390667026624, 5552.834394586114, 5561.359398977231, 1026.461107918349, 1063.4792247086586, 1114.1699433921617, 1221.3282694518157, 1276.213301378078, 675.6621689155422, 676.8781619308473, 752.7091038868367, 774.2915232562256, 818.5416166946529, 4169.91660166801, 4397.648188144941, 4872.878178045577, 4888.0, 5180.352455943007, 5688.07064361854, 5689.829305120853, 5700.7719691212715, 5715.342735585377, 5730.306755824756, 4402.647788176938, 4407.559244075567, 4942.986687729007, 5221.686698798084, 5266.236395722599, 2392.6889504364667, 2545.6054311581734, 2818.9154325370273, 2857.285678580355, 2864.7851411144247, 5055.595552355802, 5217.765200565984, 5324.840254792362, 5693.202951586781, 5704.258446401941, 4380.452443444569, 4828.959816760472, 5028.505188893684, 5158.174692049254, 5615.971920140455, 4796.952030479651, 5253.317068781034, 5553.944460555343, 5652.152177173457, 5665.66006039639, 4360.890977725456, 4602.516735742699, 5399.325084364455, 5478.096608797344, 5531.446855314436, 4304.698671092993, 5609.326880774333, 5696.629719068413, 5700.6342367918505, 5737.0, 5390.353157621111, 5671.582104473881, 5826.475617194473, 5974.416779553335, 6028.216331876828, 3001.594784704037, 3730.626937306248, 3818.415357626554, 3847.6537111658963, 3858.729888907862, 4859.052484765437, 5608.569814697226, 5726.914096288642, 5738.426157384228, 5771.278590176228, 4683.789229484613, 4815.855524334275, 5268.894622107613, 5584.804531841366, 5657.886842263214, 4817.349657796293, 5228.921566176435, 5290.312259406406, 5529.668219906818, 5655.945789273746, 4091.89770255746, 4594.310853372021, 5269.841904742864, 5439.700816455133, 5475.561955043667, 4418.668599855088, 5409.0, 5434.5652347812875, 5472.480114389126, 5593.468620481048, 4949.455559888337, 5253.159494480865, 5481.479259470344, 5492.258545096521, 5522.696251706195], "value": 3904.118053763817, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.8756105242635, 772.8840673898918, 775.9612019399032, 777.0752804163044, 778.9688412463498, 14228.786568201473, 14826.77759833602, 14859.628509287273, 14866.554003379915, 14882.776758348633, 14684.192369419678, 14754.557363279118, 14759.966802323841, 14798.112113273211, 14847.480338188165, 657.2310396835713, 676.1277951442634, 819.9549024803648, 842.9409941304111, 844.1474111147754, 808.3533173461208, 829.6805729794042, 839.6011894350196, 843.7806170395711, 845.0366582096415, 880.8634661627458, 886.5965985476593, 886.8802711633944, 887.418740724823, 889.5107690770083, 677.0487465111477, 759.7644730133649, 872.3544577013029, 881.1496905486173, 881.7707396077034, 518.2588897876036, 621.6052806467881, 641.6246495799962, 643.4209211709452, 643.4369926314475, 14071.507497237548, 14110.85889141116, 14118.223497707622, 14135.15189088658, 14140.92929535356, 12500.687482812911, 12597.244165350017, 12732.17240879349, 12852.678683032906, 12943.935280323632, 10929.234953553254, 11468.369239691814, 11552.075833933266, 12045.57840475588, 12258.0, 3678.668919797231, 3696.5564132304294, 3715.4241092630414, 3765.719655317178, 3793.6775374093236, 81718.59140704318, 86397.13602863954, 87230.563847181, 88777.0, 89549.55225223833, 10384.480775961172, 10458.63394781179, 10494.947525262478, 10562.155027597773, 10605.045545900906, 16885.577860553585, 19509.122089506007, 19725.309614163434, 19872.0, 19903.701444478345, 7110.288971102952, 7310.890336644955, 7372.189059203483, 7520.586367749826, 7555.773326800205, 4134.524529679125, 4139.751614903115, 4148.398482220122, 4192.853250136231, 4195.916081678411, 3276.45938420158, 3378.611459682168, 3381.8309084545676, 3382.983085084608, 3383.1034775784437, 630.1083966187792, 649.9740010399531, 662.3145044878528, 667.4060086522999, 668.5520701130255, 591.3436085944599, 672.3679741043403, 674.2448457727377, 674.8582797612556, 675.0920012583068, 8692.782680432912, 8773.29813614922, 9171.58727857248, 9357.625694972261, 9436.528173591292, 637.6747858592151, 644.9774257901045, 653.9084528166061, 677.7932730517141, 679.4734081087197, 4223.387608796768, 4510.188166130128, 4537.75042372666, 4569.314602809539, 4628.467726211461, 85948.7107693385, 88299.55850220707, 117764.8223517771, 123428.38285808514, 126135.36932315463, 65883.46284664427, 69756.65121674359, 108185.45907270571, 108515.91484085216, 109747.0, 92067.0, 93154.53422732843, 94385.52807236057, 95028.52485737528, 97131.51434242925, 7687.577183254974, 8696.130386961253, 8893.777655558662, 8904.955475222583, 8985.955070224607, 58202.126968094664, 58802.0, 59862.40137598568, 60111.0, 61325.0, 73122.90315645376, 76827.31104411319, 81642.59178704068, 81672.0, 85650.57174714087, 10643.042126208678, 11075.501602427748, 11933.582324618945, 11975.580854670045, 12053.096017798525, 12640.74718505643, 12696.04779641549, 12732.681682958, 12756.115318135306, 13461.596152115451, 10775.730606734895, 12833.743325133259, 12966.157199781985, 13132.73734525285, 13179.472821087049, 11935.82096268574, 12772.680682982627, 12887.35563221854, 12961.82435303319, 13071.477140914258, 12047.821899172764, 12052.758944820878, 12368.010559155426, 12542.310172940575, 12608.621741347773, 10289.74275643115, 10567.365958042543, 10624.36253824773, 10820.783584328427, 11057.557697692002, 10286.691399258034, 10792.622258220925, 10822.350658960488, 11003.889961100287, 11012.449377531251], "value": 7267.902660993892, "unit": "score"}], "name": "dromaeo_css", "value": 7025.722736816597, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 124.0, 168.0, 153.0, 115.0, 114.0, 114.0, 116.0, 116.0, 115.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 103.0, 129.0, 176.0, 139.0, 118.0, 111.0, 113.0, 141.0, 113.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 198.0, 262.0, 204.0, 181.0, 184.0, 185.0, 184.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 59.0, 91.0, 79.0, 83.0, 81.0, 71.0, 82.0, 59.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 95.0, 67.0, 67.0, 69.0, 89.0, 67.0, 68.0, 91.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 88.0, 91.0, 86.0, 91.0, 88.0, 89.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 99.0, 99.0, 112.0, 154.0, 106.0, 98.0, 99.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 124.0, 78.0, 85.0, 82.0, 83.0, 86.0, 82.0, 83.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 57.0, 59.0, 58.0, 57.0, 58.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 76.0, 77.0, 73.0, 71.0, 71.0, 74.0, 73.0, 74.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0, 84.0, 84.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 141.0, 138.0, 140.0, 144.0, 144.0, 144.0, 186.0, 139.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 167.0, 222.0, 213.0, 165.0, 166.0, 165.0, 165.0, 166.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 69.0, 66.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1493.1, "alertThreshold": 2.0}]} 02:48:19 INFO - Return code: 0 02:48:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:19 INFO - # TBPL SUCCESS # 02:48:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:48:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:48:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:48:19 INFO - 2017-01-19 02:48:19.115 screenresolution[1924:14868] starting screenresolution argv=screenresolution get 02:48:19 INFO - 2017-01-19 02:48:19.119 screenresolution[1924:14868] Display 0: 1600x1200x32@60 02:48:19 INFO - 2017-01-19 02:48:19.126 screenresolution[1925:14871] starting screenresolution argv=screenresolution list 02:48:19 INFO - Available Modes on Display 0 02:48:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:48:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:48:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:48:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:48:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:48:19 INFO - Intel Iris: 02:48:19 INFO - Chipset Model: Intel Iris 02:48:19 INFO - Type: GPU 02:48:19 INFO - Bus: Built-In 02:48:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:48:19 INFO - Vendor: Intel (0x8086) 02:48:19 INFO - Device ID: 0x0a2e 02:48:19 INFO - Revision ID: 0x0009 02:48:19 INFO - Displays: 02:48:19 INFO - Display: 02:48:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:48:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:48:19 INFO - Display Serial Number: 1600x1200 60 02:48:19 INFO - Main Display: Yes 02:48:19 INFO - Mirror: Off 02:48:19 INFO - Online: Yes 02:48:19 INFO - Rotation: Supported 02:48:19 INFO - Return code: 0 02:48:19 INFO - Running post-action listener: _resource_record_post_action 02:48:19 INFO - [mozharness: 2017-01-19 10:48:19.374707Z] Finished run-tests step (success) 02:48:19 INFO - Running post-run listener: _resource_record_post_run 02:48:19 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 921600; Write bytes: 652989440; Read time: 14; Write time: 1852 02:48:19 INFO - TinderboxPrint: CPU usage
53.4% 02:48:19 INFO - TinderboxPrint: I/O read bytes / time
921,600 / 14 02:48:19 INFO - TinderboxPrint: I/O write bytes / time
652,989,440 / 1,852 02:48:19 INFO - TinderboxPrint: CPU idle
2,257.4 (46.6%) 02:48:19 INFO - TinderboxPrint: CPU system
968.8 (20.0%) 02:48:19 INFO - TinderboxPrint: CPU user
1,619.5 (33.4%) 02:48:19 INFO - TinderboxPrint: Swap in / out
350,605,312 / 0 02:48:19 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 338639360; Write bytes: 333276672; Read time: 26618; Write time: 607 02:48:19 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 921600; Write bytes: 301932032; Read time: 14; Write time: 1191 02:48:19 INFO - Running post-run listener: _upload_blobber_files 02:48:19 INFO - Blob upload gear active. 02:48:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:19 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 02:48:19 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'] 02:48:19 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 02:48:20 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:21 INFO - (blobuploader) - INFO - Done attempting. 02:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:22 INFO - (blobuploader) - INFO - Done attempting. 02:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:24 INFO - (blobuploader) - INFO - Done attempting. 02:48:24 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:24 INFO - Return code: 0 02:48:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea64a08a782f7ef903312abd6b4ef5239a6b0d2fd3ba373e800821d048d1d6803b2eef5e780fdb8d172b61ad2438857fc32c8b1ca4666213221a48e54061a7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0de45a7b1bc0f0524bec251398b6304b32182425853a9bf79e3fbd6b26017d86bad578ce3216c3d99068f1c49553c4bfc9e6c8b2234a328204e2a0590504bb9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/722534493f7a9e6a82e1911f8246c68abb1dbeb0c0a257bb814a5fa7b0049f87c5c74c7ff063263ac872145a7d6a8814746d76845aff8fccf22e618d06cb2127"} 02:48:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:24 INFO - Contents: 02:48:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea64a08a782f7ef903312abd6b4ef5239a6b0d2fd3ba373e800821d048d1d6803b2eef5e780fdb8d172b61ad2438857fc32c8b1ca4666213221a48e54061a7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0de45a7b1bc0f0524bec251398b6304b32182425853a9bf79e3fbd6b26017d86bad578ce3216c3d99068f1c49553c4bfc9e6c8b2234a328204e2a0590504bb9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/722534493f7a9e6a82e1911f8246c68abb1dbeb0c0a257bb814a5fa7b0049f87c5c74c7ff063263ac872145a7d6a8814746d76845aff8fccf22e618d06cb2127"} 02:48:24 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:24 INFO - Copying logs to upload dir... 02:48:24 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.130881 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-01-19 02:48:24.790659) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 02:48:24.795206) ========= 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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea64a08a782f7ef903312abd6b4ef5239a6b0d2fd3ba373e800821d048d1d6803b2eef5e780fdb8d172b61ad2438857fc32c8b1ca4666213221a48e54061a7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0de45a7b1bc0f0524bec251398b6304b32182425853a9bf79e3fbd6b26017d86bad578ce3216c3d99068f1c49553c4bfc9e6c8b2234a328204e2a0590504bb9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/722534493f7a9e6a82e1911f8246c68abb1dbeb0c0a257bb814a5fa7b0049f87c5c74c7ff063263ac872145a7d6a8814746d76845aff8fccf22e618d06cb2127"} build_url:https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011024 build_url: 'https://queue.taskcluster.net/v1/task/D2x_S4mFSKOMgxMxdoIJAA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea64a08a782f7ef903312abd6b4ef5239a6b0d2fd3ba373e800821d048d1d6803b2eef5e780fdb8d172b61ad2438857fc32c8b1ca4666213221a48e54061a7e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0de45a7b1bc0f0524bec251398b6304b32182425853a9bf79e3fbd6b26017d86bad578ce3216c3d99068f1c49553c4bfc9e6c8b2234a328204e2a0590504bb9a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/722534493f7a9e6a82e1911f8246c68abb1dbeb0c0a257bb814a5fa7b0049f87c5c74c7ff063263ac872145a7d6a8814746d76845aff8fccf22e618d06cb2127"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 02:48:24.831326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 02:48:24.831614) ========= 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.8xnQXpuB1B/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.QKMvMg6Mk2/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 02:48:24.879331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 02:48:24.879621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 02:48:24.882918) ========= ========= Total master_lag: 0.25 =========